builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1450471866.81 results: success (0) buildid: 20151218113732 builduid: 3cd33f2b071948838d60a3c065c3d214 revision: ac00b0996a772cc017d2fef28b28c769507fe7b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.808908) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.809439) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.809806) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004928 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.831770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.832111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.846102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.846562) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.895836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.896183) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.896607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:06.896922) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 12:51:07-- 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% 50.9M=0s 2015-12-18 12:51:07 (50.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099413 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.008737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.009066) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021837 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.058896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.059267) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ac00b0996a772cc017d2fef28b28c769507fe7b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ac00b0996a772cc017d2fef28b28c769507fe7b2 --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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 12:51:07,518 truncating revision to first 12 chars 2015-12-18 12:51:07,518 Setting DEBUG logging. 2015-12-18 12:51:07,518 attempt 1/10 2015-12-18 12:51:07,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ac00b0996a77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 12:51:07,831 unpacking tar archive at: fx-team-ac00b0996a77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.853979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.854311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.861900) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.862204) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 12:51:07.862618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-18 12:51:07.862900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:51:08 INFO - MultiFileLogger online at 20151218 12:51:08 in /builds/slave/test 12:51:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:51:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:51:08 INFO - {'append_to_log': False, 12:51:08 INFO - 'base_work_dir': '/builds/slave/test', 12:51:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:51:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:51:08 INFO - 'branch': 'Fx-Team-Non-PGO', 12:51:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:08 INFO - 'config_files': ('talos/linux_config.py',), 12:51:08 INFO - 'default_actions': ('clobber', 12:51:08 INFO - 'read-buildbot-config', 12:51:08 INFO - 'download-and-extract', 12:51:08 INFO - 'populate-webroot', 12:51:08 INFO - 'create-virtualenv', 12:51:08 INFO - 'install', 12:51:08 INFO - 'run-tests'), 12:51:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:08 INFO - 'download_minidump_stackwalk': True, 12:51:08 INFO - 'download_symbols': 'ondemand', 12:51:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:08 INFO - 'installer_path': 'installer.exe', 12:51:08 INFO - 'log_level': 'info', 12:51:08 INFO - 'log_name': 'talos', 12:51:08 INFO - 'log_to_console': True, 12:51:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:51:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:51:08 INFO - 'opt_config_files': (), 12:51:08 INFO - 'pip_index': False, 12:51:08 INFO - 'sps_profile': False, 12:51:08 INFO - 'sps_profile_interval': 0, 12:51:08 INFO - 'suite': 'dromaeojs-e10s', 12:51:08 INFO - 'system_bits': '64', 12:51:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:08 INFO - 'title': 'talos-linux64-ix-064', 12:51:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:08 INFO - 'use_talos_json': True, 12:51:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:51:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:08 INFO - 'work_dir': 'build'} 12:51:08 INFO - ##### 12:51:08 INFO - ##### Running clobber step. 12:51:08 INFO - ##### 12:51:08 INFO - Running pre-action listener: _resource_record_pre_action 12:51:08 INFO - Running main action method: clobber 12:51:08 INFO - rmtree: /builds/slave/test/build 12:51:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:51:09 INFO - Running post-action listener: _resource_record_post_action 12:51:09 INFO - ##### 12:51:09 INFO - ##### Running read-buildbot-config step. 12:51:09 INFO - ##### 12:51:09 INFO - Running pre-action listener: _resource_record_pre_action 12:51:09 INFO - Running main action method: read_buildbot_config 12:51:09 INFO - Using buildbot properties: 12:51:09 INFO - { 12:51:09 INFO - "project": "", 12:51:09 INFO - "product": "firefox", 12:51:09 INFO - "script_repo_revision": "production", 12:51:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:51:09 INFO - "repository": "", 12:51:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:51:09 INFO - "buildid": "20151218113732", 12:51:09 INFO - "pgo_build": "False", 12:51:09 INFO - "basedir": "/builds/slave/test", 12:51:09 INFO - "buildnumber": 828, 12:51:09 INFO - "slavename": "talos-linux64-ix-064", 12:51:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:51:09 INFO - "platform": "ubuntu64_hw", 12:51:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:51:09 INFO - "branch": "fx-team", 12:51:09 INFO - "repo_path": "integration/fx-team", 12:51:09 INFO - "revision": "ac00b0996a772cc017d2fef28b28c769507fe7b2", 12:51:09 INFO - "stage_platform": "linux64", 12:51:09 INFO - "builduid": "3cd33f2b071948838d60a3c065c3d214", 12:51:09 INFO - "slavebuilddir": "test" 12:51:09 INFO - } 12:51:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:51:09 INFO - Running post-action listener: _resource_record_post_action 12:51:09 INFO - ##### 12:51:09 INFO - ##### Running download-and-extract step. 12:51:09 INFO - ##### 12:51:09 INFO - Running pre-action listener: _resource_record_pre_action 12:51:09 INFO - Running main action method: download_and_extract 12:51:09 INFO - mkdir: /builds/slave/test/build/tests 12:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:09 INFO - https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/test_packages.json 12:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/test_packages.json 12:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:51:10 INFO - Downloaded 1302 bytes. 12:51:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:51:10 INFO - Using the following test package requirements: 12:51:10 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:10 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:51:10 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'jsshell-linux-x86_64.zip'], 12:51:10 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:51:10 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:10 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:51:10 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:51:10 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:51:10 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:10 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:51:10 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:51: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')]} 12:51:10 INFO - https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:12 INFO - Downloaded 21872076 bytes. 12:51:12 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 12:51:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:12 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 12:51:13 INFO - Return code: 0 12:51:13 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 12:51:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:13 INFO - https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:14 INFO - Downloaded 21872076 bytes. 12:51:14 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 12:51:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:51:14 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 12:51:16 INFO - Return code: 0 12:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:16 INFO - https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:51:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:17 INFO - Downloaded 11132039 bytes. 12:51:17 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 12:51:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:17 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 12:51:17 INFO - Return code: 0 12:51:17 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')]} 12:51:17 INFO - https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H1xIFI0dSTSq_GDiYzSQHA/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 12:51:19 INFO - Downloaded 53061274 bytes. 12:51:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:51:19 INFO - mkdir: /builds/slave/test/properties 12:51:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:51:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:51:19 INFO - Contents: 12:51:19 INFO - build_url:https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:51:19 INFO - Running post-action listener: _resource_record_post_action 12:51:19 INFO - Running post-action listener: set_extra_try_arguments 12:51:19 INFO - ##### 12:51:19 INFO - ##### Running populate-webroot step. 12:51:19 INFO - ##### 12:51:19 INFO - Running pre-action listener: _resource_record_pre_action 12:51:19 INFO - Running main action method: populate_webroot 12:51:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:51:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:51:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:51:19 INFO - '--tppagecycles', 12:51:19 INFO - '7'], 12:51:19 INFO - 'tests': ['tsvgm']}}, 12:51:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:51:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'tests': ['damp', 'tps']}, 12:51:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['damp', 'tps']}, 12:51:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:51:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:19 INFO - 'other': {'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'other_l64': {'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'other_nol64': {'tests': ['a11yr', 12:51:19 INFO - 'ts_paint', 12:51:19 INFO - 'tpaint', 12:51:19 INFO - 'sessionrestore', 12:51:19 INFO - 'sessionrestore_no_auto_restore']}, 12:51:19 INFO - 'svgr': {'tests': ['tsvgx', 12:51:19 INFO - 'tsvgr_opacity', 12:51:19 INFO - 'tart', 12:51:19 INFO - 'tscrollx', 12:51:19 INFO - 'cart']}, 12:51:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['tsvgx', 12:51:19 INFO - 'tsvgr_opacity', 12:51:19 INFO - 'tart', 12:51:19 INFO - 'tscrollx', 12:51:19 INFO - 'cart']}, 12:51:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'tests': ['tp5o']}, 12:51:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'talos_options': ['--e10s'], 12:51:19 INFO - 'tests': ['tp5o']}, 12:51:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'talos_options': ['--xperf_path', 12:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:19 INFO - 'tests': ['tp5n']}, 12:51:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:19 INFO - 'talos_options': ['--e10s', 12:51:19 INFO - '--xperf_path', 12:51:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:19 INFO - 'tests': ['tp5n']}}, 12:51:19 INFO - 'talos.zip': {'path': '', 12:51:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:51:19 INFO - Running post-action listener: _resource_record_post_action 12:51:19 INFO - ##### 12:51:19 INFO - ##### Running create-virtualenv step. 12:51:19 INFO - ##### 12:51:19 INFO - Running pre-action listener: _resource_record_pre_action 12:51:19 INFO - Running main action method: create_virtualenv 12:51:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:51:19 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 12:51:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:51:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:19 INFO - Using real prefix '/usr' 12:51:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:22 INFO - Installing pip.................done. 12:51:22 INFO - Return code: 0 12:51:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51: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', 'pip>=1.5'] in /builds/slave/test/build 12:51: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 pip>=1.5 12:51:22 INFO - Using env: {'DISPLAY': ':0', 12:51:22 INFO - 'HOME': '/home/cltbld', 12:51:22 INFO - 'LANG': 'en_US.UTF-8', 12:51:22 INFO - 'LANGUAGE': 'en_US:en', 12:51:22 INFO - 'LOGNAME': 'cltbld', 12:51:22 INFO - 'MAIL': '/var/mail/cltbld', 12:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:22 INFO - 'MOZ_NO_REMOTE': '1', 12:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:22 INFO - 'NO_EM_RESTART': '1', 12:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:22 INFO - 'PWD': '/builds/slave/test', 12:51:22 INFO - 'SHELL': '/bin/bash', 12:51:22 INFO - 'SHLVL': '1', 12:51:22 INFO - 'TERM': 'linux', 12:51:22 INFO - 'TMOUT': '86400', 12:51:22 INFO - 'USER': 'cltbld', 12:51:22 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:22 INFO - '_': '/tools/buildbot/bin/python'} 12:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:22 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 12:51:22 INFO - Cleaning up... 12:51:22 INFO - Return code: 0 12:51:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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', '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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:51: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 psutil>=0.7.1 12:51:22 INFO - Using env: {'DISPLAY': ':0', 12:51:22 INFO - 'HOME': '/home/cltbld', 12:51:22 INFO - 'LANG': 'en_US.UTF-8', 12:51:22 INFO - 'LANGUAGE': 'en_US:en', 12:51:22 INFO - 'LOGNAME': 'cltbld', 12:51:22 INFO - 'MAIL': '/var/mail/cltbld', 12:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:22 INFO - 'MOZ_NO_REMOTE': '1', 12:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:22 INFO - 'NO_EM_RESTART': '1', 12:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:22 INFO - 'PWD': '/builds/slave/test', 12:51:22 INFO - 'SHELL': '/bin/bash', 12:51:22 INFO - 'SHLVL': '1', 12:51:22 INFO - 'TERM': 'linux', 12:51:22 INFO - 'TMOUT': '86400', 12:51:22 INFO - 'USER': 'cltbld', 12:51:22 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:22 INFO - '_': '/tools/buildbot/bin/python'} 12:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:22 INFO - Downloading/unpacking psutil>=0.7.1 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:51:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:24 INFO - Installing collected packages: psutil 12:51:24 INFO - Running setup.py install for psutil 12:51:24 INFO - building 'psutil._psutil_linux' extension 12:51:24 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 12:51:24 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 12:51:24 INFO - building 'psutil._psutil_posix' extension 12:51:24 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 12:51:25 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 12:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:25 INFO - Successfully installed psutil 12:51:25 INFO - Cleaning up... 12:51:25 INFO - Return code: 0 12:51:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:25 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 12:51:25 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 12:51:25 INFO - Using env: {'DISPLAY': ':0', 12:51:25 INFO - 'HOME': '/home/cltbld', 12:51:25 INFO - 'LANG': 'en_US.UTF-8', 12:51:25 INFO - 'LANGUAGE': 'en_US:en', 12:51:25 INFO - 'LOGNAME': 'cltbld', 12:51:25 INFO - 'MAIL': '/var/mail/cltbld', 12:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:25 INFO - 'MOZ_NO_REMOTE': '1', 12:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:25 INFO - 'NO_EM_RESTART': '1', 12:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:25 INFO - 'PWD': '/builds/slave/test', 12:51:25 INFO - 'SHELL': '/bin/bash', 12:51:25 INFO - 'SHLVL': '1', 12:51:25 INFO - 'TERM': 'linux', 12:51:25 INFO - 'TMOUT': '86400', 12:51:25 INFO - 'USER': 'cltbld', 12:51:25 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:25 INFO - '_': '/tools/buildbot/bin/python'} 12:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:51:25 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 12:51:25 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 12:51:25 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 12:51:25 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 12:51:25 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 12:51:25 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 12:51:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:51:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:51:27 INFO - Installing collected packages: mozsystemmonitor 12:51:27 INFO - Running setup.py install for mozsystemmonitor 12:51:27 INFO - Successfully installed mozsystemmonitor 12:51:27 INFO - Cleaning up... 12:51:27 INFO - Return code: 0 12:51:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:27 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:27 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 12:51:27 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 12:51:27 INFO - Using env: {'DISPLAY': ':0', 12:51:27 INFO - 'HOME': '/home/cltbld', 12:51:27 INFO - 'LANG': 'en_US.UTF-8', 12:51:27 INFO - 'LANGUAGE': 'en_US:en', 12:51:27 INFO - 'LOGNAME': 'cltbld', 12:51:27 INFO - 'MAIL': '/var/mail/cltbld', 12:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:27 INFO - 'MOZ_NO_REMOTE': '1', 12:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:27 INFO - 'NO_EM_RESTART': '1', 12:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:27 INFO - 'PWD': '/builds/slave/test', 12:51:27 INFO - 'SHELL': '/bin/bash', 12:51:27 INFO - 'SHLVL': '1', 12:51:27 INFO - 'TERM': 'linux', 12:51:27 INFO - 'TMOUT': '86400', 12:51:27 INFO - 'USER': 'cltbld', 12:51:27 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:27 INFO - '_': '/tools/buildbot/bin/python'} 12:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:27 INFO - Downloading/unpacking blobuploader==1.2.4 12:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:29 INFO - Downloading blobuploader-1.2.4.tar.gz 12:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:51:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:51:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:29 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 12:51:30 INFO - Downloading docopt-0.6.1.tar.gz 12:51:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:51:30 INFO - Installing collected packages: blobuploader, requests, docopt 12:51:30 INFO - Running setup.py install for blobuploader 12:51:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:51:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:51:30 INFO - Running setup.py install for requests 12:51:30 INFO - Running setup.py install for docopt 12:51:30 INFO - Successfully installed blobuploader requests docopt 12:51:30 INFO - Cleaning up... 12:51:30 INFO - Return code: 0 12:51:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51: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')]} 12:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:30 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:30 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 12:51:30 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 12:51:30 INFO - Using env: {'DISPLAY': ':0', 12:51:30 INFO - 'HOME': '/home/cltbld', 12:51:30 INFO - 'LANG': 'en_US.UTF-8', 12:51:30 INFO - 'LANGUAGE': 'en_US:en', 12:51:30 INFO - 'LOGNAME': 'cltbld', 12:51:30 INFO - 'MAIL': '/var/mail/cltbld', 12:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:30 INFO - 'MOZ_NO_REMOTE': '1', 12:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:30 INFO - 'NO_EM_RESTART': '1', 12:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:30 INFO - 'PWD': '/builds/slave/test', 12:51:30 INFO - 'SHELL': '/bin/bash', 12:51:30 INFO - 'SHLVL': '1', 12:51:30 INFO - 'TERM': 'linux', 12:51:30 INFO - 'TMOUT': '86400', 12:51:30 INFO - 'USER': 'cltbld', 12:51:30 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:30 INFO - '_': '/tools/buildbot/bin/python'} 12:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:30 INFO - Running setup.py (path:/tmp/pip-Yu1NFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:31 INFO - Running setup.py (path:/tmp/pip-V13WkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:31 INFO - Running setup.py (path:/tmp/pip-D_kjEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:31 INFO - Running setup.py (path:/tmp/pip-BQBMj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:31 INFO - Running setup.py (path:/tmp/pip-Hcx0pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:31 INFO - Running setup.py (path:/tmp/pip-eDDjJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:31 INFO - Running setup.py (path:/tmp/pip-IzwgRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:31 INFO - Running setup.py (path:/tmp/pip-AaeL8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:31 INFO - Running setup.py (path:/tmp/pip-knOdmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:31 INFO - Running setup.py (path:/tmp/pip-RpKXI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:31 INFO - Running setup.py (path:/tmp/pip-VO9Uxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:31 INFO - Running setup.py (path:/tmp/pip-YB1oA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:31 INFO - Running setup.py (path:/tmp/pip-cH5d1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:31 INFO - Running setup.py (path:/tmp/pip-RivHhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:31 INFO - Running setup.py (path:/tmp/pip-bfuyYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:32 INFO - Running setup.py (path:/tmp/pip-yXwN9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:32 INFO - Running setup.py (path:/tmp/pip-dE2Y_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:51:32 INFO - Running setup.py install for manifestparser 12:51:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Running setup.py install for mozcrash 12:51:32 INFO - Running setup.py install for mozdebug 12:51:32 INFO - Running setup.py install for mozdevice 12:51:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Running setup.py install for mozfile 12:51:32 INFO - Running setup.py install for mozhttpd 12:51:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Running setup.py install for mozinfo 12:51:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Running setup.py install for mozInstall 12:51:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:51:32 INFO - Running setup.py install for mozleak 12:51:33 INFO - Running setup.py install for mozlog 12:51:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Running setup.py install for moznetwork 12:51:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Running setup.py install for mozprocess 12:51:33 INFO - Running setup.py install for mozprofile 12:51:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Running setup.py install for mozrunner 12:51:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Running setup.py install for mozscreenshot 12:51:33 INFO - Running setup.py install for moztest 12:51:33 INFO - Running setup.py install for mozversion 12:51:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:33 INFO - Cleaning up... 12:51:33 INFO - Return code: 0 12:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:33 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')]} 12:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:33 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')]} 12:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:33 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:33 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 12:51:33 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 12:51:33 INFO - Using env: {'DISPLAY': ':0', 12:51:33 INFO - 'HOME': '/home/cltbld', 12:51:33 INFO - 'LANG': 'en_US.UTF-8', 12:51:33 INFO - 'LANGUAGE': 'en_US:en', 12:51:33 INFO - 'LOGNAME': 'cltbld', 12:51:33 INFO - 'MAIL': '/var/mail/cltbld', 12:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:33 INFO - 'MOZ_NO_REMOTE': '1', 12:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:33 INFO - 'NO_EM_RESTART': '1', 12:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:33 INFO - 'PWD': '/builds/slave/test', 12:51:33 INFO - 'SHELL': '/bin/bash', 12:51:33 INFO - 'SHLVL': '1', 12:51:33 INFO - 'TERM': 'linux', 12:51:33 INFO - 'TMOUT': '86400', 12:51:33 INFO - 'USER': 'cltbld', 12:51:33 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:33 INFO - '_': '/tools/buildbot/bin/python'} 12:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:34 INFO - Running setup.py (path:/tmp/pip-GYmjW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:34 INFO - Running setup.py (path:/tmp/pip-59wIWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:34 INFO - Running setup.py (path:/tmp/pip-jbpXCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:34 INFO - Running setup.py (path:/tmp/pip-VLKFBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:34 INFO - Running setup.py (path:/tmp/pip-QKzD54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:34 INFO - Running setup.py (path:/tmp/pip-fsKVOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:34 INFO - Running setup.py (path:/tmp/pip-mpvsh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:34 INFO - Running setup.py (path:/tmp/pip-F69go8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:34 INFO - Running setup.py (path:/tmp/pip-LvuIQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:34 INFO - Running setup.py (path:/tmp/pip-fLY2km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:34 INFO - Running setup.py (path:/tmp/pip-SKFPeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:34 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)) 12:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:34 INFO - Running setup.py (path:/tmp/pip-56ZkTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:35 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)) 12:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:35 INFO - Running setup.py (path:/tmp/pip-_ncdFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 12:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:35 INFO - Running setup.py (path:/tmp/pip-pT6bMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:35 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)) 12:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:35 INFO - Running setup.py (path:/tmp/pip-dRW6x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:35 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)) 12:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:35 INFO - Running setup.py (path:/tmp/pip-bVkegt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:35 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)) 12:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:35 INFO - Running setup.py (path:/tmp/pip-O1p20H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:35 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)) 12:51:35 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)) 12:51:35 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)) 12:51:35 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)) 12:51:35 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)) 12:51:35 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)) 12:51:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:35 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 12:51:35 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 12:51:35 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 12:51:35 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 12:51:35 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 12:51:35 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 12:51:37 INFO - Downloading blessings-1.5.1.tar.gz 12:51:37 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 12:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:37 INFO - Installing collected packages: blessings 12:51:37 INFO - Running setup.py install for blessings 12:51:37 INFO - Successfully installed blessings 12:51:37 INFO - Cleaning up... 12:51:37 INFO - Return code: 0 12:51:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:37 INFO - Reading from file tmpfile_stdout 12:51:37 INFO - Current package versions: 12:51:37 INFO - argparse == 1.2.1 12:51:37 INFO - blessings == 1.5.1 12:51:37 INFO - blobuploader == 1.2.4 12:51:37 INFO - docopt == 0.6.1 12:51:37 INFO - manifestparser == 1.1 12:51:37 INFO - mozInstall == 1.12 12:51:37 INFO - mozcrash == 0.16 12:51:37 INFO - mozdebug == 0.1 12:51:37 INFO - mozdevice == 0.47 12:51:37 INFO - mozfile == 1.2 12:51:37 INFO - mozhttpd == 0.7 12:51:37 INFO - mozinfo == 0.9 12:51:37 INFO - mozleak == 0.1 12:51:37 INFO - mozlog == 3.1 12:51:37 INFO - moznetwork == 0.27 12:51:37 INFO - mozprocess == 0.22 12:51:37 INFO - mozprofile == 0.27 12:51:37 INFO - mozrunner == 6.11 12:51:37 INFO - mozscreenshot == 0.1 12:51:37 INFO - mozsystemmonitor == 0.0 12:51:37 INFO - moztest == 0.7 12:51:37 INFO - mozversion == 1.4 12:51:37 INFO - psutil == 3.1.1 12:51:37 INFO - requests == 1.2.3 12:51:37 INFO - wsgiref == 0.1.2 12:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:37 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:37 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 12:51:37 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 12:51:37 INFO - Using env: {'DISPLAY': ':0', 12:51:37 INFO - 'HOME': '/home/cltbld', 12:51:37 INFO - 'LANG': 'en_US.UTF-8', 12:51:37 INFO - 'LANGUAGE': 'en_US:en', 12:51:37 INFO - 'LOGNAME': 'cltbld', 12:51:37 INFO - 'MAIL': '/var/mail/cltbld', 12:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:37 INFO - 'MOZ_NO_REMOTE': '1', 12:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:37 INFO - 'NO_EM_RESTART': '1', 12:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:37 INFO - 'PWD': '/builds/slave/test', 12:51:37 INFO - 'SHELL': '/bin/bash', 12:51:37 INFO - 'SHLVL': '1', 12:51:37 INFO - 'TERM': 'linux', 12:51:37 INFO - 'TMOUT': '86400', 12:51:37 INFO - 'USER': 'cltbld', 12:51:37 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:37 INFO - '_': '/tools/buildbot/bin/python'} 12:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:37 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 1)) 12:51:37 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 2)) 12:51:37 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 3)) 12:51:37 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 4)) 12:51:37 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 5)) 12:51:37 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 6)) 12:51:37 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 7)) 12:51:37 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 8)) 12:51:37 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:51:37 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 3)) 12:51:37 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:51:37 INFO - Cleaning up... 12:51:37 INFO - Return code: 0 12:51:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:37 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:37 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 12:51:37 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 12:51:37 INFO - Using env: {'DISPLAY': ':0', 12:51:37 INFO - 'HOME': '/home/cltbld', 12:51:37 INFO - 'LANG': 'en_US.UTF-8', 12:51:37 INFO - 'LANGUAGE': 'en_US:en', 12:51:37 INFO - 'LOGNAME': 'cltbld', 12:51:37 INFO - 'MAIL': '/var/mail/cltbld', 12:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:37 INFO - 'MOZ_NO_REMOTE': '1', 12:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:37 INFO - 'NO_EM_RESTART': '1', 12:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:37 INFO - 'PWD': '/builds/slave/test', 12:51:37 INFO - 'SHELL': '/bin/bash', 12:51:37 INFO - 'SHLVL': '1', 12:51:37 INFO - 'TERM': 'linux', 12:51:37 INFO - 'TMOUT': '86400', 12:51:37 INFO - 'USER': 'cltbld', 12:51:37 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:37 INFO - '_': '/tools/buildbot/bin/python'} 12:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:37 INFO - Downloading/unpacking jsonschema 12:51:37 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 12:51:37 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 12:51:37 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 12:51:37 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 12:51:37 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 12:51:37 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 12:51:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:51:39 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 12:51:39 INFO - Downloading/unpacking functools32 (from jsonschema) 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51: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 12:51:39 INFO - Downloading functools32-3.2.3-2.tar.gz 12:51:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:51:39 INFO - warning: no files found matching '*.txt' 12:51:39 INFO - no previously-included directories found matching 'build' 12:51:39 INFO - no previously-included directories found matching 'dist' 12:51:39 INFO - no previously-included directories found matching '.git*' 12:51:39 INFO - Installing collected packages: jsonschema, functools32 12:51:39 INFO - Running setup.py install for functools32 12:51:40 INFO - warning: no files found matching '*.txt' 12:51:40 INFO - no previously-included directories found matching 'build' 12:51:40 INFO - no previously-included directories found matching 'dist' 12:51:40 INFO - no previously-included directories found matching '.git*' 12:51:40 INFO - Successfully installed jsonschema functools32 12:51:40 INFO - Cleaning up... 12:51:40 INFO - Return code: 0 12:51:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:40 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 0x7f364a9c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', '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 12:51:40 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 12:51:40 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 12:51:40 INFO - Using env: {'DISPLAY': ':0', 12:51:40 INFO - 'HOME': '/home/cltbld', 12:51:40 INFO - 'LANG': 'en_US.UTF-8', 12:51:40 INFO - 'LANGUAGE': 'en_US:en', 12:51:40 INFO - 'LOGNAME': 'cltbld', 12:51:40 INFO - 'MAIL': '/var/mail/cltbld', 12:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:40 INFO - 'MOZ_NO_REMOTE': '1', 12:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:40 INFO - 'NO_EM_RESTART': '1', 12:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:40 INFO - 'PWD': '/builds/slave/test', 12:51:40 INFO - 'SHELL': '/bin/bash', 12:51:40 INFO - 'SHLVL': '1', 12:51:40 INFO - 'TERM': 'linux', 12:51:40 INFO - 'TMOUT': '86400', 12:51:40 INFO - 'USER': 'cltbld', 12:51:40 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:40 INFO - '_': '/tools/buildbot/bin/python'} 12:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:40 INFO - Downloading/unpacking flake8 12:51:40 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 12:51:40 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 12:51:40 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 12:51:40 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 12:51:40 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 12:51:40 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 12:51:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:51:42 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 12:51:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:51:42 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 12:51:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 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 12:51:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:42 INFO - no previously-included directories found matching 'docs/_build' 12:51:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:51:42 INFO - Running setup.py install for pep8 12:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:51:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:51:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:51:42 INFO - no previously-included directories found matching 'docs/_build' 12:51:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:51:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:51:42 INFO - Cleaning up... 12:51:42 INFO - Return code: 0 12:51:42 INFO - Running post-action listener: _resource_record_post_action 12:51:42 INFO - Running post-action listener: _start_resource_monitoring 12:51:42 INFO - Starting resource monitoring. 12:51:42 INFO - ##### 12:51:42 INFO - ##### Running install step. 12:51:42 INFO - ##### 12:51:42 INFO - Running pre-action listener: _resource_record_pre_action 12:51:42 INFO - Running main action method: install 12:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:43 INFO - Reading from file tmpfile_stdout 12:51:43 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:43 INFO - Reading from file tmpfile_stdout 12:51:43 INFO - Output received: 12:51:43 INFO - Usage: mozinstall [options] installer 12:51:43 INFO - Options: 12:51:43 INFO - -h, --help show this help message and exit 12:51:43 INFO - -d DEST, --destination=DEST 12:51:43 INFO - Directory to install application into. [default: 12:51:43 INFO - "/builds/slave/test"] 12:51:43 INFO - --app=APP Application being installed. [default: firefox] 12:51:43 INFO - mkdir: /builds/slave/test/build/application 12:51:43 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'] 12:51:43 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 12:51:58 INFO - Reading from file tmpfile_stdout 12:51:58 INFO - Output received: 12:51:58 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:58 INFO - Running post-action listener: _resource_record_post_action 12:51:58 INFO - ##### 12:51:58 INFO - ##### Running run-tests step. 12:51:58 INFO - ##### 12:51:58 INFO - Running pre-action listener: _resource_record_pre_action 12:51:58 INFO - Running main action method: run_tests 12:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:58 INFO - Python 2.7.3 12:51:58 INFO - Return code: 0 12:51:58 INFO - grabbing minidump binary from tooltool 12:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:58 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 0x23760b0>, '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 0x2376fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2377440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:58 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 12:51:58 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 12:51:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:58 INFO - Return code: 0 12:51:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:51:59 INFO - Return code: 0 12:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] in /builds/slave/test/build 12:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost 12:51:59 INFO - Using env: {'DISPLAY': ':0', 12:51:59 INFO - 'HOME': '/home/cltbld', 12:51:59 INFO - 'LANG': 'en_US.UTF-8', 12:51:59 INFO - 'LANGUAGE': 'en_US:en', 12:51:59 INFO - 'LOGNAME': 'cltbld', 12:51:59 INFO - 'MAIL': '/var/mail/cltbld', 12:51:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:59 INFO - 'MOZ_NO_REMOTE': '1', 12:51:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:59 INFO - 'NO_EM_RESTART': '1', 12:51:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:59 INFO - 'PWD': '/builds/slave/test', 12:51:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:59 INFO - 'SHELL': '/bin/bash', 12:51:59 INFO - 'SHLVL': '1', 12:51:59 INFO - 'TERM': 'linux', 12:51:59 INFO - 'TMOUT': '86400', 12:51:59 INFO - 'USER': 'cltbld', 12:51:59 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567', 12:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:59 INFO - '_': '/tools/buildbot/bin/python'} 12:51:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] with output_timeout 3600 12:51:59 INFO - mozversion INFO | application_buildid: 20151218113732 12:51:59 INFO - mozversion INFO | application_changeset: ac00b0996a772cc017d2fef28b28c769507fe7b2 12:51:59 INFO - mozversion INFO | application_display_name: Nightly 12:51:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:59 INFO - mozversion INFO | application_name: Firefox 12:51:59 INFO - mozversion INFO | application_remotingname: firefox 12:51:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:51:59 INFO - mozversion INFO | application_vendor: Mozilla 12:51:59 INFO - mozversion INFO | application_version: 46.0a1 12:51:59 INFO - mozversion INFO | platform_buildid: 20151218113732 12:51:59 INFO - mozversion INFO | platform_changeset: ac00b0996a772cc017d2fef28b28c769507fe7b2 12:51:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:51:59 INFO - mozversion INFO | platform_version: 46.0a1 12:51:59 INFO - 2015-12-18 12:51:59,826 DEBUG : using testdate: 1450471919 12:51:59 INFO - 2015-12-18 12:51:59,826 DEBUG : actual date: 1450471919 12:51:59 INFO - 2015-12-18 12:51:59,838 INFO : starting webserver on 'localhost:44911' 12:51:59 INFO - 2015-12-18 12:51:59,839 INFO : Starting test suite talos-linux64-ix-064.e 12:51:59 INFO - 2015-12-18 12:51:59,840 INFO : Starting test dromaeo_css 12:51:59 INFO - 2015-12-18 12:51:59,840 DEBUG : operating with platform_type : linux_ 12:51:59 INFO - 2015-12-18 12:51:59,840 INFO : Initialising browser for dromaeo_css test... 12:51:59 INFO - 2015-12-18 12:51:59,852 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU_bjUE/profile http://localhost:44911/getInfo.html 12:52:04 INFO - 2015-12-18 12:52:04,739 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:52:04 INFO - 2015-12-18 12:52:04,740 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:52:04 INFO - 2015-12-18 12:52:04,740 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:52:04 INFO - 2015-12-18 12:52:04,740 DEBUG : BROWSER_OUTPUT: __metrics 12:52:04 INFO - 2015-12-18 12:52:04,864 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:52:05 INFO - 2015-12-18 12:52:05,761 INFO : Browser initialized. 12:52:05 INFO - 2015-12-18 12:52:05,762 INFO : Running cycle 1/1 for dromaeo_css test... 12:52:05 INFO - 2015-12-18 12:52:05,762 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU_bjUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:52:17 INFO - 2015-12-18 12:52:17,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 150855680 12:52:17 INFO - 2015-12-18 12:52:17,800 DEBUG : BROWSER_OUTPUT: 12:53:07 INFO - 2015-12-18 12:53:07,407 DEBUG : BROWSER_OUTPUT: 1450471987404 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] 12:55:19 INFO - 2015-12-18 12:55:19,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44911/tests/dromaeo/cssquery-ext.html) 12:55:20 INFO - 2015-12-18 12:55:20,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 156233728 12:55:20 INFO - 2015-12-18 12:55:20,458 DEBUG : BROWSER_OUTPUT: 12:58:22 INFO - 2015-12-18 12:58:22,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-ext.html (next: http://localhost:44911/tests/dromaeo/cssquery-jquery.html) 12:58:23 INFO - 2015-12-18 12:58:23,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 153604096 12:58:23 INFO - 2015-12-18 12:58:23,066 DEBUG : BROWSER_OUTPUT: 13:01:24 INFO - 2015-12-18 13:01:24,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44911/tests/dromaeo/cssquery-mootools.html) 13:01:25 INFO - 2015-12-18 13:01:25,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 155049984 13:01:25 INFO - 2015-12-18 13:01:25,474 DEBUG : BROWSER_OUTPUT: 13:04:27 INFO - 2015-12-18 13:04:27,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44911/tests/dromaeo/cssquery-prototype.html) 13:04:27 INFO - 2015-12-18 13:04:27,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 152367104 13:04:27 INFO - 2015-12-18 13:04:27,846 DEBUG : BROWSER_OUTPUT: 13:07:30 INFO - 2015-12-18 13:07:30,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44911/tests/dromaeo/cssquery-yui.html) 13:07:30 INFO - 2015-12-18 13:07:30,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 152485888 13:07:30 INFO - 2015-12-18 13:07:30,972 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/dromaeo/cssquery-yui.html (next: http://localhost:44911/tests/dromaeo/cssquery-dojo.html) 13:10:33 INFO - 2015-12-18 13:10:33,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 155111424 13:10:33 INFO - 2015-12-18 13:10:33,726 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,729 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:10:33 INFO - 2015-12-18 13:10:33,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:10:33 INFO - 2015-12-18 13:10:33,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:10:33 INFO - 2015-12-18 13:10:33,730 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:10:33 INFO - 2015-12-18 13:10:33,730 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2683.8121331506795;2737.3430376709593;2766.391393893343;2770.0166440913467;2774.9861250693743;4662.370579971703;4823.807047718092;4873.049755297719;4901.975490122549;4934.284528743339;4652.97673511632;4666.510016448275;4700.976495117528;4842.418909730828;4847.539483749047;4428.623566996801;4520.321951707254;4573.359729637853;4596.195665758496;4634.860954171363;4478.03722199727;4503.909921801562;4526.615237704799;4551.4083169188125;4608.23964045932;4209.852655157055;4274.380214868826;4313.61177494027;4457.153140903218;4506.819727210907;4507.549245075499;4520.389747384127;4528.139653465864;4534.229181039232;4554.2485489894125;4487.865364039051;4494.955050449486;4500.549945005506;4502.234620114588;4506.369108324837;4523.819047238107;4634.791434385461;4679.064187162581;4778.116048530998;4793.281007848851;5194.818181363634;5249.527542521153;5262.736863156865;5269.762860671279;5278.419373868871;5287.444818294062;5300.31095957523;5302.231176479428;5305.708186049766;5332.840014799563;4601.723896566216;4734.124187025412;4812.422509298906;4885.047415753965;4923.729194894315;5278.287431196816;5393.2449457076045;5402.540784033401;5408.161734931092;5456.154296084113;4808.759562021885;5136.409312929061;5162.096633089194;5169.198774190007;5171.198464238049;5064.11378008847;5105.5149760772665;5172.612054095883;5191.922121168185;5242.554382877498;5203.375594928557;5270.051390749702;5271.05121078202;5273.34083239595;5324.627276090637;4905.48492408292;5023.6985780853265;5215.400228973641;5229.869253268699;5237.031149237327;4169.228692691861;4199.202151591188;4219;4248.936265955951;4259.531451540328;3743.382341913554;3751.6623503884234;3755.868544600926;3778.9607857838764;3797.9810100949317;4188.28799104153;4289.82840686369;4388.517263101056;4430.800613972379;4452.5992660660695;5157.097507936096;5175.120229560908;5185.870353241199;5196.168613021899;5207.1668533034535;4450.421445212101;4451.1765323415275;4455.242608756519;4493.28107502798;4507.459104907432;4276.251655960256;4397.978010109929;4565.794539245742;4577.084583083397;4693.976530117396;4896.4124305083615;4926.778294976663;4970.552650261494;4972.229304457815;4982.302477653059;5208.322918020633;5259.211118332128;5288.127458969227;5288.206768984683;5294.444083371344;4731.763411829464;4847.030593881167;4885.9022819544125;4936.728479933495;4961.627877909099;5117.360329958755;5173.042987047408;5220.9216861746345;5232.215167724872;5264.420913699413;4897.142999975062;5267.157254839208;5286.312779338815;5295.894082118413;5296.7351632418995;4813.879653008703;4823.397075365579;4936.851894443173;4998.6500944933505;5053.393592768891;5071.239314102914;5075.010372977234;5080.212567052113;5110.718910459812;5150.124478838531;4755.144074066701;4995.575376093073;5019.84940451787;5027.924581131359;5029.59763218949;4893.828715995065;5006.499350064964;5014.749262536931;5064.063148317573;5091.0581542414775;5006.148954677641;5009.3487846581165;5014.297998280316;5017.774200160929;5065.518775716301 13:10:33 INFO - 2015-12-18 13:10:33,733 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.5916401444937;561.3936948096056;561.6573889927146;569.8262030080825;600.8978473659478;33683;34464;34531;34646;34661.48007779886;36181.45727814085;36460.270794584096;36474.63525364746;36654.8167259164;36812.815935920284;7790.571518566477;7920.445568810185;7923.564203968808;7934;7943.5631040292765;7690.846183076335;7775.572343521104;7790.649420776079;7818.374530037612;7824.687012519521;7752.108507521622;7815.609219539028;7836.960815195945;7849.64676589552;7880.251376119289;7730.613469326539;7742.729004484844;7751.7674469766;7791.4156438267355;7798.688052477894;7714.190010048977;7774.455788094836;7808.336291415237;7858.960705196495;7859.96070019652;33550.49674254888;33942;34062.48906266408;34148.6585134148;34201;2976.345204055104;3032.166154307561;3068;3329.5505106810515;3491.0748651607346;27475.725242747718;27500.862495687594;27513.587296190573;27955.86022069897;28242.43515129686;3121.204092956282;3253.577034985437;3265.134739294089;3282.6389097199526;3362.5628668272966;245187;246860;247798;250472;251045.7447712768;37467.437988430196;54690.72654636701;55377.44622553723;55810.720946395006;55926.440735592936;34909.82545087258;35075.82462087673;35161.29677406437;35168.64831351654;35201.82399087988;12143.757124857453;12271.631851044483;12288.508459661693;12295.692607684701;12388.31864247457;10381.84427233592;10533.36799792015;10537.473126343652;10543.89456105429;10595.311304765166;12706.36468176606;12719.809202861965;12868.420921058574;12940.547080852313;13025.088243822842;5408.378036525771;5545.473180047889;5606.55147588192;5614.6631202128;5636.633618814764;804.6700852650386;896.5696465696502;897.6499165325529;917.9449233046039;1047.3454091193005;25157.6163311016;25585;25693.100741473958;25788.35529111787;25935.481290374086;1039.4750650921237;1062.3731998121145;1063.2132222155703;1063.776606912557;1118.770652016351;13365.997550183774;13424.26166560829;13646.24945628;13688.794668079987;13692;255818;261227;263187;263554;264146;43671.56328436675;44044.33933491;44270;44544.77727611341;44745.55254447479;1227.0551675210218;1227.5274019502556;1237.1587320622064;1241.7764802335485;1242.912996090265;24834;25571.488570228863;25720.614190787528;26091;26139.607905881046;39603.60396395999;39928;40017.1996560073;40021.1995760089;40035.3994690074;248345;252430;252690;253101;253339;28807.279818004718;28814.423711526073;29025.12924612265;29307;29434.411311774074;37794.43308350432;37923.24153516969;37948.81025594854;38211.23577528489;39016;32330.353392931538;32740.34519309648;32896.342073158885;33201.501977469874;33561.66438335683;38289;39867.2026559473;39924.401133982436;40410.19179616332;40980.79509602433;32596.185095371857;32786.836065819516;32859.50710739389;33141.66858331386;33154.66845331516;28036.85981570079;28368.43263134767;30244;30465.23836904095;30640;23468.530629387657;25255.242342729747;26358.868205658848;27254.863725681244;27625 13:10:33 INFO - 2015-12-18 13:10:33,735 DEBUG : BROWSER_OUTPUT: |2;jquery.html;309.74755574207006;315.71427857788694;316.43674259817516;331.4646845344769;336.2853935387302;14715.632109197275;15184.696306073873;15190.696186076286;15972.84027159728;16492.917535412336;10028.348157369766;10276.691699249015;13362.398692058856;14734.18961957092;14777.556673299818;4419.491758447772;4545.454545454533;4547.1587756265035;5016.097102521545;5018.322526458918;4996.475370086143;5027.09512287788;5031.144705400091;5032.043911656773;5036.471170527097;3466.9306613867707;3967.5834037425943;4935.876603084916;4991.975040124794;5258.211268309746;5147.4080480744815;5188.118019936601;5192.506711862367;5202.687838729688;5237;4967.081089998362;4969.552740253394;5020.196768517019;5115.258287548322;5124.5131712487255;18017.099145042695;18287.268509259746;18415.35546255888;19240.422787316264;19261.9036904816;1737.1748419500636;1805.7471953926329;1819.4086921750352;1903.2101677803694;1915.9137838797287;8987.782729086266;9155.633774649006;9198.310126740455;9843.90156098437;12729.108962372638;1740.582260257529;1769.6814573376787;1779.8576113910856;1790.239148361941;1801.882877612951;54181.458185418036;55820.44179558193;56216;56592.717036414964;57456.138157927664;9496.240300775922;9711.223102151811;9818;9824.263180261509;9831.31180817336;12459.190152640049;12463.252204867737;12464.439100240512;12466.252024878537;12476.438560264809;6737.326267373223;6739;6850.794476165723;6862.142232220973;6892.758753443706;6591.472682185414;6607.174103237096;6610.3720146586;6619.801405957829;6663.566868153554;4111.116110036357;4117.526484454326;4120.299549076664;4136.255474014646;4158.91682166361;1707.5731067233191;1711.238498867992;1730.6538692261597;1736.2187015842921;1740.747591599211;375.7262878840732;382.95596006459056;385.6432799660303;891.3003292415552;947.9336446448821;8966.945241362106;9647.758806029906;9769.706908792748;9886.653967111117;9931.205503559699;368.7805755575428;377.3114066827995;379.8499592660939;383.58189573365166;390.94331321958157;4312.353147027909;5309.8938021239355;5349.919751203735;5355.973220133875;5374.838754837283;319831;327017;328362;503291;508892;67657;69242;73278.6336068327;73435;73777;980.7989362180735;1025.0467065629036;1029.4389557691077;1044.968650940473;1056.4612047855649;14377.712445751236;14408.233276157855;14456.638584035483;14478.493252736103;14710.926445367704;29147.271318216364;29319.267018324714;29367.972120975664;29621.223433377614;30284;37601.62398375981;39735.60264397319;39921.60078399179;40169.79915100522;42664.573354267304;8428.199321064489;8515.105913878953;8749.256313213447;8850.645974160961;8855.690050848447;10086.445245511273;10137.797244055226;10152.543135559064;10170.08469237772;12908.806367904677;13021.934890325489;13094.476220951055;13135.868641313464;13141.868581314448;13334.066615336833;12669.113162078565;12679.366031698193;13104.541341053018;13366.128741975937;13483.595492135251;13417.597472075853;13435.952508800534;13660.726785464434;14003.579892603238;14434.133951962916;8932.19610235056;9019.098090190928;9083.409578377648;9158.95420522893;9190.770230744285;12847.164934279243;13272.80090798658;13714.542773598421;13818.37817298244;14035.50875719345 13:10:33 INFO - 2015-12-18 13:10:33,738 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1487;1632.0860318221796;1638.238219228059;1650.5130986359022;1704.7954245490544;6181.6600086995195;6364.204474440695;7164.104486939133;7364.300391462809;7369.520981136222;6954.791356259308;7068.505204635678;7173.426125909928;7183.281671832827;7192.712291508334;2051.323063389078;2073.8651987620833;2076.5431605046942;2077.626027315083;2084.2809230815346;2045.4681782736448;2088.5927244187314;2092.4350425385137;2098.223657246821;2107.6522373808302;2034.430359499335;2062.9071691773906;2090.3728881335614;2090.4878304815265;2102.8843413612244;2086.7078608994675;2105.0737675422765;2106.641870881946;2112.039022244875;2115.2913773885766;2052.6510493216188;2070.4099331690545;2092.9162833486644;2097.590969760897;2110.0715685098507;7164.462665300123;7248.456365772536;7286.74496392629;7291.526050806734;7295.671694773695;4252.255855225354;4273.893152671208;4301.892452688677;4312.8490502832565;4352.586504282088;2689.4352186040956;2711;2731;2763.101991852656;2765.5298599237976;828.6975254032235;839.9706010289672;845.953472559009;846.7671390367636;875.2866413872673;9741.269404794597;9747.805043899083;9765.609375624967;9780.755481112958;9807.656732014417;3899.7855117968215;3930.155016671429;3973.2450834341385;3996.4205190247253;4000.7999600019884;8447.619857106445;8469.11074337198;8484.830303393897;8492.830143397097;8497.150284971576;4284.828606855754;4311.784410779448;4324.762138082436;4328.415663885398;4369.060651959844;3292;3316.0714999800093;3824;3959.287328280937;3962.980185099114;3486.0761898097026;3511.0520159556777;3526.576810782671;3533.6643018913164;3535.1338921964284;1091.4379094766202;1109.628274528042;1128.9322640641587;1139.1114930354338;1139.5441823270592;992.831218692824;1011.9443430611387;1019.7705516258931;1092.4373947417087;1217.9269243845397;6799.93200067993;6870.931290687129;6877.243503214642;6917.239103698589;6917.342852429112;392.77219212856477;408.4282005192754;408.8058172368101;410.75765298474045;410.7658634578262;5317.8936421271355;5330;5370.060239458079;5402.783888644411;5405.702631368444;8552.102029286836;8799;8848.424852384574;8855.33584981129;8857.335699822539;8528.616212270463;8630.654773808978;8669.826603467895;8800.603972821238;8836.955815221012;6882.070920425778;6900.171979362509;6936.514443988873;6985.511014228955;6988.336108069725;6543.083968244355;6559.409653131241;6562.868742625025;6575.112359831553;6595.571287866273;7578.355839753683;7697.538147710931;7753.534787912743;7780.02749656293;7820.452568320163;7893.565853878092;7990.200979901963;8008.599570021592;8014.078380986261;8054.677812887653;5353.411124776349;5532.087205611029;5971.522278217819;6280.309165991646;6377.521685873671;6855.383015528626;6882.7591034313555;6904.102466679299;6904.3095690430555;6909.170899492093;6396.48828093742;6470.708818103102;6568.671566421564;6656.400923916871;6664.0670306158145;6234.875302493834;6345.682715864096;6367.395097465734;6549.770758023446;6605.042268871083;6612.603243805387;6634.436072933855;6646.169228846395;6657.900131498128;6665.700043497957;6005.669688167192;6065.5754097212775;6081.847953801191;6083.391660833881;6143.32423433413;6061.030235162353;6108.908366374419;6132.908006379818;6133.6319820810895;6186.938130618636 13:10:33 INFO - 2015-12-18 13:10:33,738 DEBUG : BROWSER_OUTPUT: |4;prototype.html;292.20374479543244;301.37013641489284;303.1753630126057;306.4820453433696;308.02203005457665;5524.889502209953;5537.695426751527;5654.57590680699;5665.660060396369;5666.291713535808;5535.723213839312;5537.307836520435;5550.944490555094;5559.360673522546;5572.136318870582;4066.329055705805;4304.741715497064;4316.179925814101;4326.9567304326865;4331.631811296028;4132.690048246379;4184.937225941613;4250.766207858566;4256.21260066887;4272.9359059614135;4237.555056719047;4246.490421149467;4251.426057482231;4251.681123915719;4251.9362209566725;4247.511536173349;4251.2347777400055;4256.957045523851;4261.254280500931;4274.914501709948;3713.4429835524616;3722.0322716093738;3724.087598538348;3726.6273372662786;3731.589525152231;5265.52610265078;5362.115250983583;5388.245645609618;5403.2165336026055;5412.783488660449;4944.110060189165;4951.207806750938;4955.752212389402;4958.082754690394;4960.156773348539;5807.680577568232;5847.736851841677;5850.3564607893095;5864;5869.882602347971;4096.549379568245;4105.645137104748;4111.239420707148;4112.753234805921;4122.546519882811;5950.166976623233;6152.661603611799;6159.7536098556;6172.84567885802;6182.856171608267;4191.434156388848;4197.706160568731;4199.68502362324;4200.05498762782;4203.810828512725;4228.492580890313;4261.232978063978;4267.0825772459075;4268.829246830154;4273.166732487197;4876.195427754452;4890.975545122252;4893.486183950705;4899.412070551485;4902.313676085351;5739.885202295931;5800.970995144998;5861;5867.941320586825;5879.2944846618675;1483.391809358158;1524.7636616324487;1526.9160196189316;1529.5487831089856;1531.8085239345082;1015.7308313296983;1020.3316827478013;1020.5101551255291;1021.274894824668;1038.9948050259852;5073.923891141636;5086.160783470686;5097.158968770112;5100.846974590768;5112.309838171874;6031.457168854824;6095.847603809941;6098.817035488853;6191.597546159485;6199.938000619936;5147.613928955343;5155.278261043457;5156.484351564814;5160.8967820643375;5163.483651634807;3270.5257737627912;3277.7869438486423;3295.9835200824323;3298.191942973987;3307.6196237433005;5620.409856965041;5719.113537401709;5734.913976290359;5739.311282646109;5741.62679425836;6307.810765677037;6311.400416960381;6318.905216421757;6329.620222786648;6341.873162536724;5744.195812586241;5749.252597162342;5751.424857514299;5758.798442054508;5770.16332631766;6107.755689772359;6140.232470941132;6141.84645383869;6148.569600127948;6159.876802464015;5846.356900741001;5927.022041363127;5943.3759455258305;5944.851378715567;5947.702614869153;5721.742521586455;5728.54171666274;5736.225609542826;5738.971305143447;5765.048766953573;4062.6343629073526;4084.060666046885;4090.4068910007286;4098.7130900836655;4105.835766569304;5965.522758179422;6161.969190154021;6169.84575385619;6176.197094377702;6182.629042257479;5871.266091738533;5919.467247947533;5922.585419020627;5942.702864856827;5943.851403714942;5902.704864756831;5910.054391297372;5912.231409916683;5925.170476133431;5931.911021334769;5634.408387119293;5778.191053252464;5781.797637082682;5790.131480277823;5807.477327040587;5983;5994.910076348945;6011.729472173675;6014.458698717136;6026.216591843032;5783.190353350618;5822.70886455684;5827.271591051119;5835.066389377679;5844.912326315024 13:10:33 INFO - 2015-12-18 13:10:33,739 DEBUG : BROWSER_OUTPUT: |5;yui.html;661.0843981086194;663.270402557187;670.256015822437;771.3019717155969;800.5276886636883;10253.692389228327;10552.947235263813;10584.047435730792;10595.470226488664;10597.152227821774;11470.082393408527;12914.870851291484;13194.274314912676;13211;13224.206547607151;769.4114002787858;783.0798811396586;791.1929831571794;799.8680217764091;802.7110240313483;794.8251384695386;801.7274126796888;803.9758807235763;806.3911746631314;807.5558442856435;818.2676504528444;819.3854609043218;819.4550623835142;820.5938060659981;820.8891799607067;806.4314658165979;808.0747544062016;808.6886548678742;809.1503920883079;815.4047545291911;604.3684349854412;605.6729366142278;606.9271687397496;607.6840043177567;612.6630353305665;10693;10750.677479675622;10789.298695584763;10831;10858.131349492021;10506.894931050669;10686.633710381206;10813.83779243312;10912.127029837595;11426.657200284004;9000.954995225047;9536.904630953672;9618.711438656852;9817.018298170125;9835.803283934281;3063.111697607691;3130.7651926105405;3139.686031396865;3143.355612099514;3144.7641426893074;39144.21711565753;39358.80320598407;39553.80223098895;39590.802045989585;39614.405783912975;8641.481511109354;8756.605952732143;8841.69054083104;8848.380613357003;8930.821383572293;15485.690286194438;15535.766963495556;15548.522890325401;15754.606134846721;15943.760843587124;6030.48740857032;6090.147379366892;6192.845178870564;6198.876022479525;6204.627722336674;3492.1444246159854;3502.5446691929887;3503.1417302760988;3543.7342199335153;3732.992092135108;2680.67831860178;2737.5893615957766;2740.369714965569;2741.465414244203;2746.299693578165;449.58638052991324;460.5440613792388;462.3665578157945;466.19581222391105;474.3951461886123;554.5369616370295;585.1544518171287;587.5710731166273;603.2459425717852;622.2968046107959;7010.404115650125;7128.394086502705;7147.714091436388;7211.675474603656;7219.675114619855;488.6091127098307;502.6707506583121;526.9446708095671;587.5857520448074;607.1712112965859;3407.9659203408146;3492.7729697569575;3883.417487376916;3901.785401802871;3964.4251583520227;46992.295115573295;50044.249336259985;50139.74930125326;51743.482565173865;56128.15807762887;42932;43797;43874.561254387685;44146.77926610346;44319.77840110779;41469.585304146574;41682.37476437856;41958;42027.7898610505;42205.78897105495;7644.885326720215;7707.34487568563;7718.228177182237;7768.262015108556;7972.681092756457;30621;30708.53937190899;31460.2134946619;31538.68461315449;31585.368292634477;36980;38872;40834.591654084266;40964.18071638491;40968.59031409767;9636.180924621485;9680.564374603018;9789.51052447389;10090.747731306776;10186.490675466346;11117.499712512794;11203.103751699682;11297.491612877277;11850.703732406759;11866.703332416759;9865;9889.703308900744;10058.597656093674;10341.844872327072;10378.377297362182;9912.801743964936;10379.959366353325;10551.78896422052;10669.51987160564;10697.732556686145;9747.268954828274;9760.219182465527;9985.700428986851;10518.211134164816;10652;9103.226225770884;9223.262139028728;9237.307201960015;9378.202852757591;9640.42157470554;8409.369297302848;8953.641854325753;9226.308026897876;9333.953330233306;9418.576164072496 13:10:33 INFO - 2015-12-18 13:10:33,739 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1450473033727__endTimestamp 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4783.72 Median:4901.98 stddev:524.48 (10.7%) stddev-sans-first:499.55 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: Values: 2683.8 2737.3 2766.4 2770.0 2775.0 4662.4 4823.8 4873.0 4902.0 4934.3 4653.0 4666.5 4701.0 4842.4 4847.5 4428.6 4520.3 4573.4 4596.2 4634.9 4478.0 4503.9 4526.6 4551.4 4608.2 4209.9 4274.4 4313.6 4457.2 4506.8 4507.5 4520.4 4528.1 4534.2 4554.2 4487.9 4495.0 4500.5 4502.2 4506.4 4523.8 4634.8 4679.1 4778.1 4793.3 5194.8 5249.5 5262.7 5269.8 5278.4 5287.4 5300.3 5302.2 5305.7 5332.8 4601.7 4734.1 4812.4 4885.0 4923.7 5278.3 5393.2 5402.5 5408.2 5456.2 4808.8 5136.4 5162.1 5169.2 5171.2 5064.1 5105.5 5172.6 5191.9 5242.6 5203.4 5270.1 5271.1 5273.3 5324.6 4905.5 5023.7 5215.4 5229.9 5237.0 4169.2 4199.2 4219.0 4248.9 4259.5 3743.4 3751.7 3755.9 3779.0 3798.0 4188.3 4289.8 4388.5 4430.8 4452.6 5157.1 5175.1 5185.9 5196.2 5207.2 4450.4 4451.2 4455.2 4493.3 4507.5 4276.3 4398.0 4565.8 4577.1 4694.0 4896.4 4926.8 4970.6 4972.2 4982.3 5208.3 5259.2 5288.1 5288.2 5294.4 4731.8 4847.0 4885.9 4936.7 4961.6 5117.4 5173.0 5220.9 5232.2 5264.4 4897.1 5267.2 5286.3 5295.9 5296.7 4813.9 4823.4 4936.9 4998.7 5053.4 5071.2 5075.0 5080.2 5110.7 5150.1 4755.1 4995.6 5019.8 5027.9 5029.6 4893.8 5006.5 5014.7 5064.1 5091.1 5006.1 5009.3 5014.3 5017.8 5065.5 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,740 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40264.76 Median:33178.09 stddev:66240.77 (199.7%) stddev-sans-first:66359.50 13:10:33 INFO - 2015-12-18 13:10:33,741 DEBUG : BROWSER_OUTPUT: Values: 555.6 561.4 561.7 569.8 600.9 33683.0 34464.0 34531.0 34646.0 34661.5 36181.5 36460.3 36474.6 36654.8 36812.8 7790.6 7920.4 7923.6 7934.0 7943.6 7690.8 7775.6 7790.6 7818.4 7824.7 7752.1 7815.6 7837.0 7849.6 7880.3 7730.6 7742.7 7751.8 7791.4 7798.7 7714.2 7774.5 7808.3 7859.0 7860.0 33550.5 33942.0 34062.5 34148.7 34201.0 2976.3 3032.2 3068.0 3329.6 3491.1 27475.7 27500.9 27513.6 27955.9 28242.4 3121.2 3253.6 3265.1 3282.6 3362.6 245187.0 246860.0 247798.0 250472.0 251045.7 37467.4 54690.7 55377.4 55810.7 55926.4 34909.8 35075.8 35161.3 35168.6 35201.8 12143.8 12271.6 12288.5 12295.7 12388.3 10381.8 10533.4 10537.5 10543.9 10595.3 12706.4 12719.8 12868.4 12940.5 13025.1 5408.4 5545.5 5606.6 5614.7 5636.6 804.7 896.6 897.6 917.9 1047.3 25157.6 25585.0 25693.1 25788.4 25935.5 1039.5 1062.4 1063.2 1063.8 1118.8 13366.0 13424.3 13646.2 13688.8 13692.0 255818.0 261227.0 263187.0 263554.0 264146.0 43671.6 44044.3 44270.0 44544.8 44745.6 1227.1 1227.5 1237.2 1241.8 1242.9 24834.0 25571.5 25720.6 26091.0 26139.6 39603.6 39928.0 40017.2 40021.2 40035.4 248345.0 252430.0 252690.0 253101.0 253339.0 28807.3 28814.4 29025.1 29307.0 29434.4 37794.4 37923.2 37948.8 38211.2 39016.0 32330.4 32740.3 32896.3 33201.5 33561.7 38289.0 39867.2 39924.4 40410.2 40980.8 32596.2 32786.8 32859.5 33141.7 33154.7 28036.9 28368.4 30244.0 30465.2 30640.0 23468.5 25255.2 26358.9 27254.9 27625.0 13:10:33 INFO - 2015-12-18 13:10:33,741 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,741 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23181.15 Median:384.61 stddev:66835.98 (17377.5%) stddev-sans-first:67001.41 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: Values: 309.7 315.7 316.4 331.5 336.3 14715.6 15184.7 15190.7 15972.8 16492.9 10028.3 10276.7 13362.4 14734.2 14777.6 4419.5 4545.5 4547.2 5016.1 5018.3 4996.5 5027.1 5031.1 5032.0 5036.5 3466.9 3967.6 4935.9 4992.0 5258.2 5147.4 5188.1 5192.5 5202.7 5237.0 4967.1 4969.6 5020.2 5115.3 5124.5 18017.1 18287.3 18415.4 19240.4 19261.9 1737.2 1805.7 1819.4 1903.2 1915.9 8987.8 9155.6 9198.3 9843.9 12729.1 1740.6 1769.7 1779.9 1790.2 1801.9 54181.5 55820.4 56216.0 56592.7 57456.1 9496.2 9711.2 9818.0 9824.3 9831.3 12459.2 12463.3 12464.4 12466.3 12476.4 6737.3 6739.0 6850.8 6862.1 6892.8 6591.5 6607.2 6610.4 6619.8 6663.6 4111.1 4117.5 4120.3 4136.3 4158.9 1707.6 1711.2 1730.7 1736.2 1740.7 375.7 383.0 385.6 891.3 947.9 8966.9 9647.8 9769.7 9886.7 9931.2 368.8 377.3 379.8 383.6 390.9 4312.4 5309.9 5349.9 5356.0 5374.8 319831.0 327017.0 328362.0 503291.0 508892.0 67657.0 69242.0 73278.6 73435.0 73777.0 980.8 1025.0 1029.4 1045.0 1056.5 14377.7 14408.2 14456.6 14478.5 14710.9 29147.3 29319.3 29368.0 29621.2 30284.0 37601.6 39735.6 39921.6 40169.8 42664.6 8428.2 8515.1 8749.3 8850.6 8855.7 10086.4 10137.8 10152.5 10170.1 12908.8 13021.9 13094.5 13135.9 13141.9 13334.1 12669.1 12679.4 13104.5 13366.1 13483.6 13417.6 13436.0 13660.7 14003.6 14434.1 8932.2 9019.1 9083.4 9159.0 9190.8 12847.2 13272.8 13714.5 13818.4 14035.5 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5029.26 Median:6162.49 stddev:2645.70 (42.9%) stddev-sans-first:2639.72 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: Values: 1487.0 1632.1 1638.2 1650.5 1704.8 6181.7 6364.2 7164.1 7364.3 7369.5 6954.8 7068.5 7173.4 7183.3 7192.7 2051.3 2073.9 2076.5 2077.6 2084.3 2045.5 2088.6 2092.4 2098.2 2107.7 2034.4 2062.9 2090.4 2090.5 2102.9 2086.7 2105.1 2106.6 2112.0 2115.3 2052.7 2070.4 2092.9 2097.6 2110.1 7164.5 7248.5 7286.7 7291.5 7295.7 4252.3 4273.9 4301.9 4312.8 4352.6 2689.4 2711.0 2731.0 2763.1 2765.5 828.7 840.0 846.0 846.8 875.3 9741.3 9747.8 9765.6 9780.8 9807.7 3899.8 3930.2 3973.2 3996.4 4000.8 8447.6 8469.1 8484.8 8492.8 8497.2 4284.8 4311.8 4324.8 4328.4 4369.1 3292.0 3316.1 3824.0 3959.3 3963.0 3486.1 3511.1 3526.6 3533.7 3535.1 1091.4 1109.6 1128.9 1139.1 1139.5 992.8 1011.9 1019.8 1092.4 1217.9 6799.9 6870.9 6877.2 6917.2 6917.3 392.8 408.4 408.8 410.8 410.8 5317.9 5330.0 5370.1 5402.8 5405.7 8552.1 8799.0 8848.4 8855.3 8857.3 8528.6 8630.7 8669.8 8800.6 8837.0 6882.1 6900.2 6936.5 6985.5 6988.3 6543.1 6559.4 6562.9 6575.1 6595.6 7578.4 7697.5 7753.5 7780.0 7820.5 7893.6 7990.2 8008.6 8014.1 8054.7 5353.4 5532.1 5971.5 6280.3 6377.5 6855.4 6882.8 6904.1 6904.3 6909.2 6396.5 6470.7 6568.7 6656.4 6664.1 6234.9 6345.7 6367.4 6549.8 6605.0 6612.6 6634.4 6646.2 6657.9 6665.7 6005.7 6065.6 6081.8 6083.4 6143.3 6061.0 6108.9 6132.9 6133.6 6186.9 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4866.70 Median:5530.31 stddev:1443.28 (26.1%) stddev-sans-first:1405.90 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: Values: 292.2 301.4 303.2 306.5 308.0 5524.9 5537.7 5654.6 5665.7 5666.3 5535.7 5537.3 5550.9 5559.4 5572.1 4066.3 4304.7 4316.2 4327.0 4331.6 4132.7 4184.9 4250.8 4256.2 4272.9 4237.6 4246.5 4251.4 4251.7 4251.9 4247.5 4251.2 4257.0 4261.3 4274.9 3713.4 3722.0 3724.1 3726.6 3731.6 5265.5 5362.1 5388.2 5403.2 5412.8 4944.1 4951.2 4955.8 4958.1 4960.2 5807.7 5847.7 5850.4 5864.0 5869.9 4096.5 4105.6 4111.2 4112.8 4122.5 5950.2 6152.7 6159.8 6172.8 6182.9 4191.4 4197.7 4199.7 4200.1 4203.8 4228.5 4261.2 4267.1 4268.8 4273.2 4876.2 4891.0 4893.5 4899.4 4902.3 5739.9 5801.0 5861.0 5867.9 5879.3 1483.4 1524.8 1526.9 1529.5 1531.8 1015.7 1020.3 1020.5 1021.3 1039.0 5073.9 5086.2 5097.2 5100.8 5112.3 6031.5 6095.8 6098.8 6191.6 6199.9 5147.6 5155.3 5156.5 5160.9 5163.5 3270.5 3277.8 3296.0 3298.2 3307.6 5620.4 5719.1 5734.9 5739.3 5741.6 6307.8 6311.4 6318.9 6329.6 6341.9 5744.2 5749.3 5751.4 5758.8 5770.2 6107.8 6140.2 6141.8 6148.6 6159.9 5846.4 5927.0 5943.4 5944.9 5947.7 5721.7 5728.5 5736.2 5739.0 5765.0 4062.6 4084.1 4090.4 4098.7 4105.8 5965.5 6162.0 6169.8 6176.2 6182.6 5871.3 5919.5 5922.6 5942.7 5943.9 5902.7 5910.1 5912.2 5925.2 5931.9 5634.4 5778.2 5781.8 5790.1 5807.5 5983.0 5994.9 6011.7 6014.5 6026.2 5783.2 5822.7 5827.3 5835.1 5844.9 13:10:33 INFO - 2015-12-18 13:10:33,742 DEBUG : BROWSER_OUTPUT: 13:10:33 INFO - 2015-12-18 13:10:33,743 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12132.78 Median:23733.35 stddev:13910.57 (58.6%) stddev-sans-first:13922.91 13:10:33 INFO - 2015-12-18 13:10:33,744 DEBUG : BROWSER_OUTPUT: Values: 661.1 663.3 670.3 771.3 800.5 10253.7 10552.9 10584.0 10595.5 10597.2 11470.1 12914.9 13194.3 13211.0 13224.2 769.4 783.1 791.2 799.9 802.7 794.8 801.7 804.0 806.4 807.6 818.3 819.4 819.5 820.6 820.9 806.4 808.1 808.7 809.2 815.4 604.4 605.7 606.9 607.7 612.7 10693.0 10750.7 10789.3 10831.0 10858.1 10506.9 10686.6 10813.8 10912.1 11426.7 9001.0 9536.9 9618.7 9817.0 9835.8 3063.1 3130.8 3139.7 3143.4 3144.8 39144.2 39358.8 39553.8 39590.8 39614.4 8641.5 8756.6 8841.7 8848.4 8930.8 15485.7 15535.8 15548.5 15754.6 15943.8 6030.5 6090.1 6192.8 6198.9 6204.6 3492.1 3502.5 3503.1 3543.7 3733.0 2680.7 2737.6 2740.4 2741.5 2746.3 449.6 460.5 462.4 466.2 474.4 554.5 585.2 587.6 603.2 622.3 7010.4 7128.4 7147.7 7211.7 7219.7 488.6 502.7 526.9 587.6 607.2 3408.0 3492.8 3883.4 3901.8 3964.4 46992.3 50044.2 50139.7 51743.5 56128.2 42932.0 43797.0 43874.6 44146.8 44319.8 41469.6 41682.4 41958.0 42027.8 42205.8 7644.9 7707.3 7718.2 7768.3 7972.7 30621.0 30708.5 31460.2 31538.7 31585.4 36980.0 38872.0 40834.6 40964.2 40968.6 9636.2 9680.6 9789.5 10090.7 10186.5 11117.5 11203.1 11297.5 11850.7 11866.7 9865.0 9889.7 10058.6 10341.8 10378.4 9912.8 10380.0 10551.8 10669.5 10697.7 9747.3 9760.2 9985.7 10518.2 10652.0 9103.2 9223.3 9237.3 9378.2 9640.4 8409.4 8953.6 9226.3 9334.0 9418.6 13:10:33 INFO - 2015-12-18 13:10:33,744 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:10:33 INFO - 2015-12-18 13:10:33,744 DEBUG : BROWSER_OUTPUT: 13:10:34 INFO - 2015-12-18 13:10:34,441 INFO : Browser exited with error code: 0 13:10:34 INFO - 2015-12-18 13:10:34,465 INFO : Completed test dromaeo_css (00:18:34) 13:10:34 INFO - 2015-12-18 13:10:34,465 INFO : Starting test kraken 13:10:34 INFO - 2015-12-18 13:10:34,465 DEBUG : operating with platform_type : linux_ 13:10:34 INFO - 2015-12-18 13:10:34,465 INFO : Initialising browser for kraken test... 13:10:34 INFO - 2015-12-18 13:10:34,471 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIbv7wf/profile http://localhost:44911/getInfo.html 13:10:38 INFO - 2015-12-18 13:10:38,835 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:10:38 INFO - 2015-12-18 13:10:38,835 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:10:38 INFO - 2015-12-18 13:10:38,835 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:10:38 INFO - 2015-12-18 13:10:38,835 DEBUG : BROWSER_OUTPUT: __metrics 13:10:38 INFO - 2015-12-18 13:10:38,972 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:10:39 INFO - 2015-12-18 13:10:39,833 INFO : Browser initialized. 13:10:39 INFO - 2015-12-18 13:10:39,834 INFO : Running cycle 1/1 for kraken test... 13:10:39 INFO - 2015-12-18 13:10:39,834 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIbv7wf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:10:51 INFO - 2015-12-18 13:10:51,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 150687744 13:10:51 INFO - 2015-12-18 13:10:51,762 DEBUG : BROWSER_OUTPUT: 13:10:54 INFO - 2015-12-18 13:10:54,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44911/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:54 INFO - 2015-12-18 13:10:54,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 152125440 13:10:54 INFO - 2015-12-18 13:10:54,925 DEBUG : BROWSER_OUTPUT: 13:10:57 INFO - 2015-12-18 13:10:57,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44911/tests/kraken/driver.html?testName=audio-dft) 13:10:58 INFO - 2015-12-18 13:10:58,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 151248896 13:10:58 INFO - 2015-12-18 13:10:58,305 DEBUG : BROWSER_OUTPUT: 13:11:01 INFO - 2015-12-18 13:11:01,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44911/tests/kraken/driver.html?testName=audio-fft) 13:11:01 INFO - 2015-12-18 13:11:01,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 144994304 13:11:01 INFO - 2015-12-18 13:11:01,833 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-12-18 13:11:03,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44911/tests/kraken/driver.html?testName=audio-oscillator) 13:11:04 INFO - 2015-12-18 13:11:04,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 145862656 13:11:04 INFO - 2015-12-18 13:11:04,473 DEBUG : BROWSER_OUTPUT: 13:11:06 INFO - 2015-12-18 13:11:06,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:07 INFO - 2015-12-18 13:11:07,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 146264064 13:11:07 INFO - 2015-12-18 13:11:07,317 DEBUG : BROWSER_OUTPUT: 13:11:10 INFO - 2015-12-18 13:11:10,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44911/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:10 INFO - 2015-12-18 13:11:10,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 147361792 13:11:10 INFO - 2015-12-18 13:11:10,982 DEBUG : BROWSER_OUTPUT: 13:11:14 INFO - 2015-12-18 13:11:14,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44911/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:15 INFO - 2015-12-18 13:11:15,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 146374656 13:11:15 INFO - 2015-12-18 13:11:15,038 DEBUG : BROWSER_OUTPUT: 13:11:18 INFO - 2015-12-18 13:11:18,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44911/tests/kraken/driver.html?testName=json-parse-financial) 13:11:18 INFO - 2015-12-18 13:11:18,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 147075072 13:11:18 INFO - 2015-12-18 13:11:18,595 DEBUG : BROWSER_OUTPUT: 13:11:20 INFO - 2015-12-18 13:11:20,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:20 INFO - 2015-12-18 13:11:20,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 147783680 13:11:20 INFO - 2015-12-18 13:11:20,971 DEBUG : BROWSER_OUTPUT: 13:11:22 INFO - 2015-12-18 13:11:22,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:23 INFO - 2015-12-18 13:11:23,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 147136512 13:11:23 INFO - 2015-12-18 13:11:23,489 DEBUG : BROWSER_OUTPUT: 13:11:25 INFO - 2015-12-18 13:11:25,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:26 INFO - 2015-12-18 13:11:26,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 147337216 13:11:26 INFO - 2015-12-18 13:11:26,268 DEBUG : BROWSER_OUTPUT: 13:11:28 INFO - 2015-12-18 13:11:28,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:29 INFO - 2015-12-18 13:11:29,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 147873792 13:11:29 INFO - 2015-12-18 13:11:29,435 DEBUG : BROWSER_OUTPUT: 13:11:32 INFO - 2015-12-18 13:11:32,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:11:32 INFO - 2015-12-18 13:11:32,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 147161088 13:11:32 INFO - 2015-12-18 13:11:32,603 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44911/tests/kraken/driver.html?testName=ai-astar) 13:11:34 INFO - 2015-12-18 13:11:34,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 148070400 13:11:34 INFO - 2015-12-18 13:11:34,628 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,629 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:11:34 INFO - 2015-12-18 13:11:34,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:11:34 INFO - 2015-12-18 13:11:34,629 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;108;112;114;113;123;113;112;111;112 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;131;155;172;133;166;162;139;178;137 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;165;166;165;164;173;162;167;163 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;74;74;128;73;74;72;73;87 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;134;93;94;96;133;95;95;128 13:11:34 INFO - 2015-12-18 13:11:34,630 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;114;110;109;110;110;109;110;110 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;149;147;147;147;149;148;148;148 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;104;96;96;96;96;99;96;96 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;75;74;75;75;75;74;75;78;74 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;73;67;73;67;67;68;68;68 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;85;86;83;84;84;85;83;82;83 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;123;125;123;134;131;127;125;128 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;144;158;146;151;136;147;145;150;134 13:11:34 INFO - 2015-12-18 13:11:34,631 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;70;74;70;72;69;70;71;71;70 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,768 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1450473094627__endTimestamp 13:11:34 INFO - 2015-12-18 13:11:34,632 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:3.85 (3.4%) stddev-sans-first:4.08 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: Values: 114.0 108.0 112.0 114.0 113.0 123.0 113.0 112.0 111.0 112.0 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.30 Median:161.00 stddev:17.08 (10.6%) stddev-sans-first:17.94 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: Values: 160.0 131.0 155.0 172.0 133.0 166.0 162.0 139.0 178.0 137.0 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.21 (1.9%) stddev-sans-first:3.38 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 165.0 166.0 165.0 164.0 173.0 162.0 167.0 163.0 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,640 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:17.36 (23.5%) stddev-sans-first:18.31 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 74.0 74.0 128.0 73.0 74.0 72.0 73.0 87.0 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:94.50 stddev:18.00 (19.0%) stddev-sans-first:18.67 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 134.0 93.0 94.0 96.0 133.0 95.0 95.0 128.0 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:1.40 (1.3%) stddev-sans-first:1.48 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 114.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 149.0 147.0 147.0 147.0 149.0 148.0 148.0 148.0 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:2.60 (2.7%) stddev-sans-first:2.73 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 104.0 96.0 96.0 96.0 96.0 99.0 96.0 96.0 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,641 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.10 Median:75.00 stddev:1.20 (1.6%) stddev-sans-first:1.22 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 76.0 75.0 74.0 75.0 75.0 75.0 74.0 75.0 78.0 74.0 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.00 stddev:2.31 (3.4%) stddev-sans-first:2.44 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 73.0 67.0 73.0 67.0 67.0 68.0 68.0 68.0 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:2.27 (2.7%) stddev-sans-first:1.27 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 90.0 85.0 86.0 83.0 84.0 84.0 85.0 83.0 82.0 83.0 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:4.06 (3.2%) stddev-sans-first:4.15 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 123.0 125.0 123.0 134.0 131.0 127.0 125.0 128.0 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:146.50 stddev:8.02 (5.5%) stddev-sans-first:7.37 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 133.0 144.0 158.0 146.0 151.0 136.0 147.0 145.0 150.0 134.0 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.73 (2.4%) stddev-sans-first:1.48 13:11:34 INFO - 2015-12-18 13:11:34,642 DEBUG : BROWSER_OUTPUT: Values: 74.0 70.0 74.0 70.0 72.0 69.0 70.0 71.0 71.0 70.0 13:11:34 INFO - 2015-12-18 13:11:34,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:11:34 INFO - 2015-12-18 13:11:34,643 DEBUG : BROWSER_OUTPUT: 13:11:35 INFO - 2015-12-18 13:11:35,521 INFO : Browser exited with error code: 0 13:11:35 INFO - 2015-12-18 13:11:35,575 INFO : Completed test kraken (00:01:01) 13:11:35 INFO - 2015-12-18 13:11:35,576 INFO : Starting test v8_7 13:11:35 INFO - 2015-12-18 13:11:35,576 DEBUG : operating with platform_type : linux_ 13:11:35 INFO - 2015-12-18 13:11:35,576 INFO : Initialising browser for v8_7 test... 13:11:35 INFO - 2015-12-18 13:11:35,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7zYhU/profile http://localhost:44911/getInfo.html 13:11:40 INFO - 2015-12-18 13:11:40,012 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:11:40 INFO - 2015-12-18 13:11:40,012 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:11:40 INFO - 2015-12-18 13:11:40,013 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:11:40 INFO - 2015-12-18 13:11:40,013 DEBUG : BROWSER_OUTPUT: __metrics 13:11:40 INFO - 2015-12-18 13:11:40,117 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:11:40 INFO - 2015-12-18 13:11:40,997 INFO : Browser initialized. 13:11:40 INFO - 2015-12-18 13:11:40,998 INFO : Running cycle 1/1 for v8_7 test... 13:11:40 INFO - 2015-12-18 13:11:40,998 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7zYhU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:11:52 INFO - 2015-12-18 13:11:52,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 151044096 13:11:52 INFO - 2015-12-18 13:11:52,978 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44911/tests/v8_7/run.html (next: http://localhost:44911/tests/v8_7/run.html) 13:12:14 INFO - 2015-12-18 13:12:14,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 145235968 13:12:14 INFO - 2015-12-18 13:12:14,683 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,683 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:14 INFO - 2015-12-18 13:12:14,683 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:14 INFO - 2015-12-18 13:12:14,683 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |0;Richards;164.50074025333114 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.131498470948 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1052.6315789473683 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |5;Earley;732.2604242867593 13:12:14 INFO - 2015-12-18 13:12:14,684 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 13:12:14 INFO - 2015-12-18 13:12:14,685 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 13:12:14 INFO - 2015-12-18 13:12:14,685 DEBUG : BROWSER_OUTPUT: |8;Splay;607.90273556231 13:12:14 INFO - 2015-12-18 13:12:14,685 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:12:14 INFO - 2015-12-18 13:12:14,685 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:14 INFO - 2015-12-18 13:12:14,685 DEBUG : BROWSER_OUTPUT: __startTimestamp1450473134681__endTimestamp 13:12:14 INFO - 2015-12-18 13:12:14,686 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,686 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:14 INFO - 2015-12-18 13:12:14,686 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:12:14 INFO - 2015-12-18 13:12:14,686 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,687 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: Values: 164.5 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.13 Median:191.13 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: Values: 191.1 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,688 DEBUG : BROWSER_OUTPUT: Values: 280.0 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: Values: 5202.1 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: Values: 1052.6 13:12:14 INFO - 2015-12-18 13:12:14,689 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:732.26 Median:732.26 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: Values: 732.3 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: Values: 12195.1 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,690 DEBUG : BROWSER_OUTPUT: Values: 26025.6 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: Values: 607.9 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:12:14 INFO - 2015-12-18 13:12:14,691 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:14 INFO - 2015-12-18 13:12:14,692 DEBUG : BROWSER_OUTPUT: 13:12:15 INFO - 2015-12-18 13:12:15,622 INFO : Browser exited with error code: 0 13:12:15 INFO - 2015-12-18 13:12:15,634 INFO : Completed test v8_7 (00:00:40) 13:12:15 INFO - 2015-12-18 13:12:15,660 INFO : Completed test suite (00:20:15) 13:12:15 INFO - 2015-12-18 13:12:15,660 DEBUG : Working with test: dromaeo_css 13:12:15 INFO - 2015-12-18 13:12:15,660 DEBUG : Generating results file: dromaeo_css 13:12:15 INFO - 2015-12-18 13:12:15,661 DEBUG : Working with test: kraken 13:12:15 INFO - 2015-12-18 13:12:15,661 DEBUG : Generating results file: kraken 13:12:15 INFO - 2015-12-18 13:12:15,662 INFO : javascript benchmark 13:12:15 INFO - 2015-12-18 13:12:15,662 DEBUG : Working with test: v8_7 13:12:15 INFO - 2015-12-18 13:12:15,662 DEBUG : Generating results file: v8_7 13:12:15 INFO - 2015-12-18 13:12:15,662 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:15 INFO - 2015-12-18 13:12:15,718 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:12:15 INFO - 2015-12-18 13:12:15,718 DEBUG : process_Request line: dromaeo_css 6223.69 graph.html#tests=[[72,132,43]] 13:12:15 INFO - 2015-12-18 13:12:15,719 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:15 INFO - 2015-12-18 13:12:15,750 DEBUG : process_Request line: kraken 1542.40 graph.html#tests=[[232,132,43]] 13:12:15 INFO - 2015-12-18 13:12:15,751 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:15 INFO - 2015-12-18 13:12:15,783 DEBUG : process_Request line: v8_7 21270.39 graph.html#tests=[[230,132,43]] 13:12:15 INFO - 2015-12-18 13:12:15,784 INFO : javascript benchmark 13:12:15 INFO - 2015-12-18 13:12:15,788 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2683.8121331506795, 2737.3430376709593, 2766.391393893343, 2770.0166440913467, 2774.9861250693743, 4662.370579971703, 4823.807047718092, 4873.049755297719, 4901.975490122549, 4934.284528743339, 4652.97673511632, 4666.510016448275, 4700.976495117528, 4842.418909730828, 4847.539483749047, 4428.623566996801, 4520.321951707254, 4573.359729637853, 4596.195665758496, 4634.860954171363, 4478.03722199727, 4503.909921801562, 4526.615237704799, 4551.4083169188125, 4608.23964045932, 4209.852655157055, 4274.380214868826, 4313.61177494027, 4457.153140903218, 4506.819727210907, 4507.549245075499, 4520.389747384127, 4528.139653465864, 4534.229181039232, 4554.2485489894125, 4487.865364039051, 4494.955050449486, 4500.549945005506, 4502.234620114588, 4506.369108324837, 4523.819047238107, 4634.791434385461, 4679.064187162581, 4778.116048530998, 4793.281007848851, 5194.818181363634, 5249.527542521153, 5262.736863156865, 5269.762860671279, 5278.419373868871, 5287.444818294062, 5300.31095957523, 5302.231176479428, 5305.708186049766, 5332.840014799563, 4601.723896566216, 4734.124187025412, 4812.422509298906, 4885.047415753965, 4923.729194894315, 5278.287431196816, 5393.2449457076045, 5402.540784033401, 5408.161734931092, 5456.154296084113, 4808.759562021885, 5136.409312929061, 5162.096633089194, 5169.198774190007, 5171.198464238049, 5064.11378008847, 5105.5149760772665, 5172.612054095883, 5191.922121168185, 5242.554382877498, 5203.375594928557, 5270.051390749702, 5271.05121078202, 5273.34083239595, 5324.627276090637, 4905.48492408292, 5023.6985780853265, 5215.400228973641, 5229.869253268699, 5237.031149237327, 4169.228692691861, 4199.202151591188, 4219.0, 4248.936265955951, 4259.531451540328, 3743.382341913554, 3751.6623503884234, 3755.868544600926, 3778.9607857838764, 3797.9810100949317, 4188.28799104153, 4289.82840686369, 4388.517263101056, 4430.800613972379, 4452.5992660660695, 5157.097507936096, 5175.120229560908, 5185.870353241199, 5196.168613021899, 5207.1668533034535, 4450.421445212101, 4451.1765323415275, 4455.242608756519, 4493.28107502798, 4507.459104907432, 4276.251655960256, 4397.978010109929, 4565.794539245742, 4577.084583083397, 4693.976530117396, 4896.4124305083615, 4926.778294976663, 4970.552650261494, 4972.229304457815, 4982.302477653059, 5208.322918020633, 5259.211118332128, 5288.127458969227, 5288.206768984683, 5294.444083371344, 4731.763411829464, 4847.030593881167, 4885.9022819544125, 4936.728479933495, 4961.627877909099, 5117.360329958755, 5173.042987047408, 5220.9216861746345, 5232.215167724872, 5264.420913699413, 4897.142999975062, 5267.157254839208, 5286.312779338815, 5295.894082118413, 5296.7351632418995, 4813.879653008703, 4823.397075365579, 4936.851894443173, 4998.6500944933505, 5053.393592768891, 5071.239314102914, 5075.010372977234, 5080.212567052113, 5110.718910459812, 5150.124478838531, 4755.144074066701, 4995.575376093073, 5019.84940451787, 5027.924581131359, 5029.59763218949, 4893.828715995065, 5006.499350064964, 5014.749262536931, 5064.063148317573, 5091.0581542414775, 5006.148954677641, 5009.3487846581165, 5014.297998280316, 5017.774200160929, 5065.518775716301], "unit": "score", "name": "dojo.html", "value": 4750.037657036418}, {"lowerIsBetter": false, "replicates": [555.5916401444937, 561.3936948096056, 561.6573889927146, 569.8262030080825, 600.8978473659478, 33683.0, 34464.0, 34531.0, 34646.0, 34661.48007779886, 36181.45727814085, 36460.270794584096, 36474.63525364746, 36654.8167259164, 36812.815935920284, 7790.571518566477, 7920.445568810185, 7923.564203968808, 7934.0, 7943.5631040292765, 7690.846183076335, 7775.572343521104, 7790.649420776079, 7818.374530037612, 7824.687012519521, 7752.108507521622, 7815.609219539028, 7836.960815195945, 7849.64676589552, 7880.251376119289, 7730.613469326539, 7742.729004484844, 7751.7674469766, 7791.4156438267355, 7798.688052477894, 7714.190010048977, 7774.455788094836, 7808.336291415237, 7858.960705196495, 7859.96070019652, 33550.49674254888, 33942.0, 34062.48906266408, 34148.6585134148, 34201.0, 2976.345204055104, 3032.166154307561, 3068.0, 3329.5505106810515, 3491.0748651607346, 27475.725242747718, 27500.862495687594, 27513.587296190573, 27955.86022069897, 28242.43515129686, 3121.204092956282, 3253.577034985437, 3265.134739294089, 3282.6389097199526, 3362.5628668272966, 245187.0, 246860.0, 247798.0, 250472.0, 251045.7447712768, 37467.437988430196, 54690.72654636701, 55377.44622553723, 55810.720946395006, 55926.440735592936, 34909.82545087258, 35075.82462087673, 35161.29677406437, 35168.64831351654, 35201.82399087988, 12143.757124857453, 12271.631851044483, 12288.508459661693, 12295.692607684701, 12388.31864247457, 10381.84427233592, 10533.36799792015, 10537.473126343652, 10543.89456105429, 10595.311304765166, 12706.36468176606, 12719.809202861965, 12868.420921058574, 12940.547080852313, 13025.088243822842, 5408.378036525771, 5545.473180047889, 5606.55147588192, 5614.6631202128, 5636.633618814764, 804.6700852650386, 896.5696465696502, 897.6499165325529, 917.9449233046039, 1047.3454091193005, 25157.6163311016, 25585.0, 25693.100741473958, 25788.35529111787, 25935.481290374086, 1039.4750650921237, 1062.3731998121145, 1063.2132222155703, 1063.776606912557, 1118.770652016351, 13365.997550183774, 13424.26166560829, 13646.24945628, 13688.794668079987, 13692.0, 255818.0, 261227.0, 263187.0, 263554.0, 264146.0, 43671.56328436675, 44044.33933491, 44270.0, 44544.77727611341, 44745.55254447479, 1227.0551675210218, 1227.5274019502556, 1237.1587320622064, 1241.7764802335485, 1242.912996090265, 24834.0, 25571.488570228863, 25720.614190787528, 26091.0, 26139.607905881046, 39603.60396395999, 39928.0, 40017.1996560073, 40021.1995760089, 40035.3994690074, 248345.0, 252430.0, 252690.0, 253101.0, 253339.0, 28807.279818004718, 28814.423711526073, 29025.12924612265, 29307.0, 29434.411311774074, 37794.43308350432, 37923.24153516969, 37948.81025594854, 38211.23577528489, 39016.0, 32330.353392931538, 32740.34519309648, 32896.342073158885, 33201.501977469874, 33561.66438335683, 38289.0, 39867.2026559473, 39924.401133982436, 40410.19179616332, 40980.79509602433, 32596.185095371857, 32786.836065819516, 32859.50710739389, 33141.66858331386, 33154.66845331516, 28036.85981570079, 28368.43263134767, 30244.0, 30465.23836904095, 30640.0, 23468.530629387657, 25255.242342729747, 26358.868205658848, 27254.863725681244, 27625.0], "unit": "score", "name": "ext.html", "value": 16255.698742886832}, {"lowerIsBetter": false, "replicates": [309.74755574207006, 315.71427857788694, 316.43674259817516, 331.4646845344769, 336.2853935387302, 14715.632109197275, 15184.696306073873, 15190.696186076286, 15972.84027159728, 16492.917535412336, 10028.348157369766, 10276.691699249015, 13362.398692058856, 14734.18961957092, 14777.556673299818, 4419.491758447772, 4545.454545454533, 4547.1587756265035, 5016.097102521545, 5018.322526458918, 4996.475370086143, 5027.09512287788, 5031.144705400091, 5032.043911656773, 5036.471170527097, 3466.9306613867707, 3967.5834037425943, 4935.876603084916, 4991.975040124794, 5258.211268309746, 5147.4080480744815, 5188.118019936601, 5192.506711862367, 5202.687838729688, 5237.0, 4967.081089998362, 4969.552740253394, 5020.196768517019, 5115.258287548322, 5124.5131712487255, 18017.099145042695, 18287.268509259746, 18415.35546255888, 19240.422787316264, 19261.9036904816, 1737.1748419500636, 1805.7471953926329, 1819.4086921750352, 1903.2101677803694, 1915.9137838797287, 8987.782729086266, 9155.633774649006, 9198.310126740455, 9843.90156098437, 12729.108962372638, 1740.582260257529, 1769.6814573376787, 1779.8576113910856, 1790.239148361941, 1801.882877612951, 54181.458185418036, 55820.44179558193, 56216.0, 56592.717036414964, 57456.138157927664, 9496.240300775922, 9711.223102151811, 9818.0, 9824.263180261509, 9831.31180817336, 12459.190152640049, 12463.252204867737, 12464.439100240512, 12466.252024878537, 12476.438560264809, 6737.326267373223, 6739.0, 6850.794476165723, 6862.142232220973, 6892.758753443706, 6591.472682185414, 6607.174103237096, 6610.3720146586, 6619.801405957829, 6663.566868153554, 4111.116110036357, 4117.526484454326, 4120.299549076664, 4136.255474014646, 4158.91682166361, 1707.5731067233191, 1711.238498867992, 1730.6538692261597, 1736.2187015842921, 1740.747591599211, 375.7262878840732, 382.95596006459056, 385.6432799660303, 891.3003292415552, 947.9336446448821, 8966.945241362106, 9647.758806029906, 9769.706908792748, 9886.653967111117, 9931.205503559699, 368.7805755575428, 377.3114066827995, 379.8499592660939, 383.58189573365166, 390.94331321958157, 4312.353147027909, 5309.8938021239355, 5349.919751203735, 5355.973220133875, 5374.838754837283, 319831.0, 327017.0, 328362.0, 503291.0, 508892.0, 67657.0, 69242.0, 73278.6336068327, 73435.0, 73777.0, 980.7989362180735, 1025.0467065629036, 1029.4389557691077, 1044.968650940473, 1056.4612047855649, 14377.712445751236, 14408.233276157855, 14456.638584035483, 14478.493252736103, 14710.926445367704, 29147.271318216364, 29319.267018324714, 29367.972120975664, 29621.223433377614, 30284.0, 37601.62398375981, 39735.60264397319, 39921.60078399179, 40169.79915100522, 42664.573354267304, 8428.199321064489, 8515.105913878953, 8749.256313213447, 8850.645974160961, 8855.690050848447, 10086.445245511273, 10137.797244055226, 10152.543135559064, 10170.08469237772, 12908.806367904677, 13021.934890325489, 13094.476220951055, 13135.868641313464, 13141.868581314448, 13334.066615336833, 12669.113162078565, 12679.366031698193, 13104.541341053018, 13366.128741975937, 13483.595492135251, 13417.597472075853, 13435.952508800534, 13660.726785464434, 14003.579892603238, 14434.133951962916, 8932.19610235056, 9019.098090190928, 9083.409578377648, 9158.95420522893, 9190.770230744285, 12847.164934279243, 13272.80090798658, 13714.542773598421, 13818.37817298244, 14035.50875719345], "unit": "score", "name": "jquery.html", "value": 7525.447668046325}, {"lowerIsBetter": false, "replicates": [1487.0, 1632.0860318221796, 1638.238219228059, 1650.5130986359022, 1704.7954245490544, 6181.6600086995195, 6364.204474440695, 7164.104486939133, 7364.300391462809, 7369.520981136222, 6954.791356259308, 7068.505204635678, 7173.426125909928, 7183.281671832827, 7192.712291508334, 2051.323063389078, 2073.8651987620833, 2076.5431605046942, 2077.626027315083, 2084.2809230815346, 2045.4681782736448, 2088.5927244187314, 2092.4350425385137, 2098.223657246821, 2107.6522373808302, 2034.430359499335, 2062.9071691773906, 2090.3728881335614, 2090.4878304815265, 2102.8843413612244, 2086.7078608994675, 2105.0737675422765, 2106.641870881946, 2112.039022244875, 2115.2913773885766, 2052.6510493216188, 2070.4099331690545, 2092.9162833486644, 2097.590969760897, 2110.0715685098507, 7164.462665300123, 7248.456365772536, 7286.74496392629, 7291.526050806734, 7295.671694773695, 4252.255855225354, 4273.893152671208, 4301.892452688677, 4312.8490502832565, 4352.586504282088, 2689.4352186040956, 2711.0, 2731.0, 2763.101991852656, 2765.5298599237976, 828.6975254032235, 839.9706010289672, 845.953472559009, 846.7671390367636, 875.2866413872673, 9741.269404794597, 9747.805043899083, 9765.609375624967, 9780.755481112958, 9807.656732014417, 3899.7855117968215, 3930.155016671429, 3973.2450834341385, 3996.4205190247253, 4000.7999600019884, 8447.619857106445, 8469.11074337198, 8484.830303393897, 8492.830143397097, 8497.150284971576, 4284.828606855754, 4311.784410779448, 4324.762138082436, 4328.415663885398, 4369.060651959844, 3292.0, 3316.0714999800093, 3824.0, 3959.287328280937, 3962.980185099114, 3486.0761898097026, 3511.0520159556777, 3526.576810782671, 3533.6643018913164, 3535.1338921964284, 1091.4379094766202, 1109.628274528042, 1128.9322640641587, 1139.1114930354338, 1139.5441823270592, 992.831218692824, 1011.9443430611387, 1019.7705516258931, 1092.4373947417087, 1217.9269243845397, 6799.93200067993, 6870.931290687129, 6877.243503214642, 6917.239103698589, 6917.342852429112, 392.77219212856477, 408.4282005192754, 408.8058172368101, 410.75765298474045, 410.7658634578262, 5317.8936421271355, 5330.0, 5370.060239458079, 5402.783888644411, 5405.702631368444, 8552.102029286836, 8799.0, 8848.424852384574, 8855.33584981129, 8857.335699822539, 8528.616212270463, 8630.654773808978, 8669.826603467895, 8800.603972821238, 8836.955815221012, 6882.070920425778, 6900.171979362509, 6936.514443988873, 6985.511014228955, 6988.336108069725, 6543.083968244355, 6559.409653131241, 6562.868742625025, 6575.112359831553, 6595.571287866273, 7578.355839753683, 7697.538147710931, 7753.534787912743, 7780.02749656293, 7820.452568320163, 7893.565853878092, 7990.200979901963, 8008.599570021592, 8014.078380986261, 8054.677812887653, 5353.411124776349, 5532.087205611029, 5971.522278217819, 6280.309165991646, 6377.521685873671, 6855.383015528626, 6882.7591034313555, 6904.102466679299, 6904.3095690430555, 6909.170899492093, 6396.48828093742, 6470.708818103102, 6568.671566421564, 6656.400923916871, 6664.0670306158145, 6234.875302493834, 6345.682715864096, 6367.395097465734, 6549.770758023446, 6605.042268871083, 6612.603243805387, 6634.436072933855, 6646.169228846395, 6657.900131498128, 6665.700043497957, 6005.669688167192, 6065.5754097212775, 6081.847953801191, 6083.391660833881, 6143.32423433413, 6061.030235162353, 6108.908366374419, 6132.908006379818, 6133.6319820810895, 6186.938130618636], "unit": "score", "name": "mootools.html", "value": 4040.4768289922804}, {"lowerIsBetter": false, "replicates": [292.20374479543244, 301.37013641489284, 303.1753630126057, 306.4820453433696, 308.02203005457665, 5524.889502209953, 5537.695426751527, 5654.57590680699, 5665.660060396369, 5666.291713535808, 5535.723213839312, 5537.307836520435, 5550.944490555094, 5559.360673522546, 5572.136318870582, 4066.329055705805, 4304.741715497064, 4316.179925814101, 4326.9567304326865, 4331.631811296028, 4132.690048246379, 4184.937225941613, 4250.766207858566, 4256.21260066887, 4272.9359059614135, 4237.555056719047, 4246.490421149467, 4251.426057482231, 4251.681123915719, 4251.9362209566725, 4247.511536173349, 4251.2347777400055, 4256.957045523851, 4261.254280500931, 4274.914501709948, 3713.4429835524616, 3722.0322716093738, 3724.087598538348, 3726.6273372662786, 3731.589525152231, 5265.52610265078, 5362.115250983583, 5388.245645609618, 5403.2165336026055, 5412.783488660449, 4944.110060189165, 4951.207806750938, 4955.752212389402, 4958.082754690394, 4960.156773348539, 5807.680577568232, 5847.736851841677, 5850.3564607893095, 5864.0, 5869.882602347971, 4096.549379568245, 4105.645137104748, 4111.239420707148, 4112.753234805921, 4122.546519882811, 5950.166976623233, 6152.661603611799, 6159.7536098556, 6172.84567885802, 6182.856171608267, 4191.434156388848, 4197.706160568731, 4199.68502362324, 4200.05498762782, 4203.810828512725, 4228.492580890313, 4261.232978063978, 4267.0825772459075, 4268.829246830154, 4273.166732487197, 4876.195427754452, 4890.975545122252, 4893.486183950705, 4899.412070551485, 4902.313676085351, 5739.885202295931, 5800.970995144998, 5861.0, 5867.941320586825, 5879.2944846618675, 1483.391809358158, 1524.7636616324487, 1526.9160196189316, 1529.5487831089856, 1531.8085239345082, 1015.7308313296983, 1020.3316827478013, 1020.5101551255291, 1021.274894824668, 1038.9948050259852, 5073.923891141636, 5086.160783470686, 5097.158968770112, 5100.846974590768, 5112.309838171874, 6031.457168854824, 6095.847603809941, 6098.817035488853, 6191.597546159485, 6199.938000619936, 5147.613928955343, 5155.278261043457, 5156.484351564814, 5160.8967820643375, 5163.483651634807, 3270.5257737627912, 3277.7869438486423, 3295.9835200824323, 3298.191942973987, 3307.6196237433005, 5620.409856965041, 5719.113537401709, 5734.913976290359, 5739.311282646109, 5741.62679425836, 6307.810765677037, 6311.400416960381, 6318.905216421757, 6329.620222786648, 6341.873162536724, 5744.195812586241, 5749.252597162342, 5751.424857514299, 5758.798442054508, 5770.16332631766, 6107.755689772359, 6140.232470941132, 6141.84645383869, 6148.569600127948, 6159.876802464015, 5846.356900741001, 5927.022041363127, 5943.3759455258305, 5944.851378715567, 5947.702614869153, 5721.742521586455, 5728.54171666274, 5736.225609542826, 5738.971305143447, 5765.048766953573, 4062.6343629073526, 4084.060666046885, 4090.4068910007286, 4098.7130900836655, 4105.835766569304, 5965.522758179422, 6161.969190154021, 6169.84575385619, 6176.197094377702, 6182.629042257479, 5871.266091738533, 5919.467247947533, 5922.585419020627, 5942.702864856827, 5943.851403714942, 5902.704864756831, 5910.054391297372, 5912.231409916683, 5925.170476133431, 5931.911021334769, 5634.408387119293, 5778.191053252464, 5781.797637082682, 5790.131480277823, 5807.477327040587, 5983.0, 5994.910076348945, 6011.729472173675, 6014.458698717136, 6026.216591843032, 5783.190353350618, 5822.70886455684, 5827.271591051119, 5835.066389377679, 5844.912326315024], "unit": "score", "name": "prototype.html", "value": 4398.5009536844045}, {"lowerIsBetter": false, "replicates": [661.0843981086194, 663.270402557187, 670.256015822437, 771.3019717155969, 800.5276886636883, 10253.692389228327, 10552.947235263813, 10584.047435730792, 10595.470226488664, 10597.152227821774, 11470.082393408527, 12914.870851291484, 13194.274314912676, 13211.0, 13224.206547607151, 769.4114002787858, 783.0798811396586, 791.1929831571794, 799.8680217764091, 802.7110240313483, 794.8251384695386, 801.7274126796888, 803.9758807235763, 806.3911746631314, 807.5558442856435, 818.2676504528444, 819.3854609043218, 819.4550623835142, 820.5938060659981, 820.8891799607067, 806.4314658165979, 808.0747544062016, 808.6886548678742, 809.1503920883079, 815.4047545291911, 604.3684349854412, 605.6729366142278, 606.9271687397496, 607.6840043177567, 612.6630353305665, 10693.0, 10750.677479675622, 10789.298695584763, 10831.0, 10858.131349492021, 10506.894931050669, 10686.633710381206, 10813.83779243312, 10912.127029837595, 11426.657200284004, 9000.954995225047, 9536.904630953672, 9618.711438656852, 9817.018298170125, 9835.803283934281, 3063.111697607691, 3130.7651926105405, 3139.686031396865, 3143.355612099514, 3144.7641426893074, 39144.21711565753, 39358.80320598407, 39553.80223098895, 39590.802045989585, 39614.405783912975, 8641.481511109354, 8756.605952732143, 8841.69054083104, 8848.380613357003, 8930.821383572293, 15485.690286194438, 15535.766963495556, 15548.522890325401, 15754.606134846721, 15943.760843587124, 6030.48740857032, 6090.147379366892, 6192.845178870564, 6198.876022479525, 6204.627722336674, 3492.1444246159854, 3502.5446691929887, 3503.1417302760988, 3543.7342199335153, 3732.992092135108, 2680.67831860178, 2737.5893615957766, 2740.369714965569, 2741.465414244203, 2746.299693578165, 449.58638052991324, 460.5440613792388, 462.3665578157945, 466.19581222391105, 474.3951461886123, 554.5369616370295, 585.1544518171287, 587.5710731166273, 603.2459425717852, 622.2968046107959, 7010.404115650125, 7128.394086502705, 7147.714091436388, 7211.675474603656, 7219.675114619855, 488.6091127098307, 502.6707506583121, 526.9446708095671, 587.5857520448074, 607.1712112965859, 3407.9659203408146, 3492.7729697569575, 3883.417487376916, 3901.785401802871, 3964.4251583520227, 46992.295115573295, 50044.249336259985, 50139.74930125326, 51743.482565173865, 56128.15807762887, 42932.0, 43797.0, 43874.561254387685, 44146.77926610346, 44319.77840110779, 41469.585304146574, 41682.37476437856, 41958.0, 42027.7898610505, 42205.78897105495, 7644.885326720215, 7707.34487568563, 7718.228177182237, 7768.262015108556, 7972.681092756457, 30621.0, 30708.53937190899, 31460.2134946619, 31538.68461315449, 31585.368292634477, 36980.0, 38872.0, 40834.591654084266, 40964.18071638491, 40968.59031409767, 9636.180924621485, 9680.564374603018, 9789.51052447389, 10090.747731306776, 10186.490675466346, 11117.499712512794, 11203.103751699682, 11297.491612877277, 11850.703732406759, 11866.703332416759, 9865.0, 9889.703308900744, 10058.597656093674, 10341.844872327072, 10378.377297362182, 9912.801743964936, 10379.959366353325, 10551.78896422052, 10669.51987160564, 10697.732556686145, 9747.268954828274, 9760.219182465527, 9985.700428986851, 10518.211134164816, 10652.0, 9103.226225770884, 9223.262139028728, 9237.307201960015, 9378.202852757591, 9640.42157470554, 8409.369297302848, 8953.641854325753, 9226.308026897876, 9333.953330233306, 9418.576164072496], "unit": "score", "name": "yui.html", "value": 5626.984089834699}], "name": "dromaeo_css", "value": 6223.692104269436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 112.0, 114.0, 113.0, 123.0, 113.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [160.0, 131.0, 155.0, 172.0, 133.0, 166.0, 162.0, 139.0, 178.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 153.3}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 165.0, 166.0, 165.0, 164.0, 173.0, 162.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 74.0, 74.0, 128.0, 73.0, 74.0, 72.0, 73.0, 87.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 134.0, 93.0, 94.0, 96.0, 133.0, 95.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 114.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 104.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 74.0, 75.0, 75.0, 75.0, 74.0, 75.0, 78.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 75.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 73.0, 67.0, 73.0, 67.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 86.0, 83.0, 84.0, 84.0, 85.0, 83.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 123.0, 125.0, 123.0, 134.0, 131.0, 127.0, 125.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [133.0, 144.0, 158.0, 146.0, 151.0, 136.0, 147.0, 145.0, 150.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 74.0, 70.0, 72.0, 69.0, 70.0, 71.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1542.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.50074025333114], "unit": "score", "name": "Richards", "value": 214.60085799999993}, {"lowerIsBetter": false, "replicates": [191.131498470948], "unit": "score", "name": "DeltaBlue", "value": 345.9293760000001}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1052.6315789473683], "unit": "score", "name": "RayTrace", "value": 702.9895499999999}, {"lowerIsBetter": false, "replicates": [732.2604242867593], "unit": "score", "name": "Earley", "value": 910.1447762237763}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21270.385253030647}]} 13:12:15 INFO - RETURN: dromaeo_css: 6223.69 13:12:15 INFO - RETURN: kraken: 1542.40 13:12:15 INFO - RETURN: v8_7: 21270.39 13:12:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21270.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6223.69"}}} 13:12:15 INFO - Return code: 0 13:12:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:12:15 INFO - # TBPL SUCCESS # 13:12:15 INFO - Running post-action listener: _resource_record_post_action 13:12:15 INFO - Running post-run listener: _resource_record_post_run 13:12:16 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547819520; Read time: 12; Write time: 394632 13:12:16 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227471360; Read time: 0; Write time: 202268 13:12:16 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320348160; Read time: 12; Write time: 192364 13:12:16 INFO - Running post-run listener: _upload_blobber_files 13:12:16 INFO - Blob upload gear active. 13:12:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:12:16 INFO - Copying logs to upload dir... 13:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.727734 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-18 13:12:16.584519) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 13:12:16.588582) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009988 build_url: 'https://queue.taskcluster.net/v1/task/H1xIFI0dSTSq_GDiYzSQHA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 13:12:16.640256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:12:16.640633) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450471866.516625-1142282567 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 13:12:16.691179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 13:12:16.691636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 13:12:16.692095) ========= ========= Total master_lag: 0.20 =========