builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1456832942.13 results: success (0) buildid: 20160301022840 builduid: 88ffaad9de9c4e7491ee5d8cda378404 revision: 1c87ce4424478e99539f4b054ba0e6b0576ce8ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.126963) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.127377) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.127661) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.151981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.155291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.182071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.182453) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.232057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.233371) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.233773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.234057) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 03:49:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.1M=0s 2016-03-01 03:49:02 (35.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.359703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.360016) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.409951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:02.410304) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1c87ce4424478e99539f4b054ba0e6b0576ce8ec --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 1c87ce4424478e99539f4b054ba0e6b0576ce8ec --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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 03:49:03,053 truncating revision to first 12 chars 2016-03-01 03:49:03,053 Setting DEBUG logging. 2016-03-01 03:49:03,053 attempt 1/10 2016-03-01 03:49:03,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1c87ce442447?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 03:49:03,366 unpacking tar archive at: fx-team-1c87ce442447/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:03.056303) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:03.056719) ========= echo 1c87ce4424478e99539f4b054ba0e6b0576ce8ec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1c87ce4424478e99539f4b054ba0e6b0576ce8ec'] 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1c87ce4424478e99539f4b054ba0e6b0576ce8ec program finished with exit code 0 elapsedTime=0.003936 script_repo_revision: '1c87ce4424478e99539f4b054ba0e6b0576ce8ec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:03.105883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:03.106184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 03:49:03.116896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-03-01 03:49:03.117306) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:49:03 INFO - MultiFileLogger online at 20160301 03:49:03 in /builds/slave/test 03:49:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:49:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:03 INFO - {'append_to_log': False, 03:49:03 INFO - 'base_work_dir': '/builds/slave/test', 03:49:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:49:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:03 INFO - 'branch': 'Fx-Team-Non-PGO', 03:49:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:03 INFO - 'config_files': ('talos/linux_config.py',), 03:49:03 INFO - 'default_actions': ('clobber', 03:49:03 INFO - 'read-buildbot-config', 03:49:03 INFO - 'download-and-extract', 03:49:03 INFO - 'populate-webroot', 03:49:03 INFO - 'create-virtualenv', 03:49:03 INFO - 'install', 03:49:03 INFO - 'run-tests'), 03:49:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:03 INFO - 'download_minidump_stackwalk': True, 03:49:03 INFO - 'download_symbols': 'ondemand', 03:49:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:03 INFO - 'installer_path': 'installer.exe', 03:49:03 INFO - 'log_level': 'info', 03:49:03 INFO - 'log_name': 'talos', 03:49:03 INFO - 'log_to_console': True, 03:49:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:49:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:49:03 INFO - 'opt_config_files': (), 03:49:03 INFO - 'pip_index': False, 03:49:03 INFO - 'sps_profile': False, 03:49:03 INFO - 'sps_profile_interval': 0, 03:49:03 INFO - 'suite': 'dromaeojs-e10s', 03:49:03 INFO - 'system_bits': '32', 03:49:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:03 INFO - 'title': 'talos-linux64-ix-012', 03:49:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:03 INFO - 'use_talos_json': True, 03:49:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:03 INFO - 'work_dir': 'build'} 03:49:03 INFO - ##### 03:49:03 INFO - ##### Running clobber step. 03:49:03 INFO - ##### 03:49:03 INFO - Running pre-action listener: _resource_record_pre_action 03:49:03 INFO - Running main action method: clobber 03:49:03 INFO - rmtree: /builds/slave/test/build 03:49:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:04 INFO - Running post-action listener: _resource_record_post_action 03:49:04 INFO - ##### 03:49:04 INFO - ##### Running read-buildbot-config step. 03:49:04 INFO - ##### 03:49:04 INFO - Running pre-action listener: _resource_record_pre_action 03:49:04 INFO - Running main action method: read_buildbot_config 03:49:04 INFO - Using buildbot properties: 03:49:04 INFO - { 03:49:04 INFO - "project": "", 03:49:04 INFO - "product": "firefox", 03:49:04 INFO - "script_repo_revision": "production", 03:49:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:49:04 INFO - "repository": "", 03:49:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:49:04 INFO - "buildid": "20160301022840", 03:49:04 INFO - "pgo_build": "False", 03:49:04 INFO - "basedir": "/builds/slave/test", 03:49:04 INFO - "buildnumber": 921, 03:49:04 INFO - "slavename": "talos-linux64-ix-012", 03:49:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:49:04 INFO - "platform": "ubuntu64_hw", 03:49:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:49:04 INFO - "branch": "fx-team", 03:49:04 INFO - "repo_path": "integration/fx-team", 03:49:04 INFO - "revision": "1c87ce4424478e99539f4b054ba0e6b0576ce8ec", 03:49:04 INFO - "stage_platform": "linux64", 03:49:04 INFO - "builduid": "88ffaad9de9c4e7491ee5d8cda378404", 03:49:04 INFO - "slavebuilddir": "test" 03:49:04 INFO - } 03:49:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 03:49:04 INFO - Running post-action listener: _resource_record_post_action 03:49:04 INFO - ##### 03:49:04 INFO - ##### Running download-and-extract step. 03:49:04 INFO - ##### 03:49:04 INFO - Running pre-action listener: _resource_record_pre_action 03:49:04 INFO - Running main action method: download_and_extract 03:49:04 INFO - mkdir: /builds/slave/test/build/tests 03:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:04 INFO - https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:49:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/test_packages.json 03:49:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/test_packages.json 03:49:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:49:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:49:05 INFO - Downloaded 1448 bytes. 03:49:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:49:05 INFO - Using the following test package requirements: 03:49:05 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:49:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:49:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:49:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'jsshell-linux-x86_64.zip'], 03:49:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:49:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:49:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:49:05 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:49:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:49:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 03:49:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 03:49:05 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:49:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:05 INFO - https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:49:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:06 INFO - Downloaded 22065168 bytes. 03:49:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:49:08 INFO - Return code: 0 03:49:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:49:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:08 INFO - https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:49:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 03:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:49:11 INFO - Downloaded 22065168 bytes. 03:49:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:49:12 INFO - Return code: 0 03:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:12 INFO - https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 03:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:49:13 INFO - Downloaded 10713410 bytes. 03:49:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:49:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:49:13 INFO - Return code: 0 03:49: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')]} 03:49:13 INFO - https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:49:15 INFO - Downloaded 54834562 bytes. 03:49:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:49:15 INFO - mkdir: /builds/slave/test/properties 03:49:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:49:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:49:15 INFO - Contents: 03:49:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 03:49:15 INFO - Running post-action listener: _resource_record_post_action 03:49:15 INFO - Running post-action listener: set_extra_try_arguments 03:49:15 INFO - ##### 03:49:15 INFO - ##### Running populate-webroot step. 03:49:15 INFO - ##### 03:49:15 INFO - Running pre-action listener: _resource_record_pre_action 03:49:15 INFO - Running main action method: populate_webroot 03:49:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:49:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:49:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:49:15 INFO - '--tppagecycles', 03:49:15 INFO - '7'], 03:49:15 INFO - 'tests': ['tsvgm']}}, 03:49:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:49:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:49:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:49:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:49:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:49:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'tests': ['damp', 'tps']}, 03:49:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['damp', 'tps']}, 03:49:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:49:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:49:15 INFO - 'other': {'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'other_l64': {'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:49:15 INFO - 'ts_paint', 03:49:15 INFO - 'tpaint', 03:49:15 INFO - 'sessionrestore', 03:49:15 INFO - 'sessionrestore_no_auto_restore']}, 03:49:15 INFO - 'svgr': {'tests': ['tsvgx', 03:49:15 INFO - 'tsvgr_opacity', 03:49:15 INFO - 'tart', 03:49:15 INFO - 'tscrollx', 03:49:15 INFO - 'cart']}, 03:49:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['tsvgx', 03:49:15 INFO - 'tsvgr_opacity', 03:49:15 INFO - 'tart', 03:49:15 INFO - 'tscrollx', 03:49:15 INFO - 'cart']}, 03:49:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'tests': ['tp5o']}, 03:49:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'talos_options': ['--e10s'], 03:49:15 INFO - 'tests': ['tp5o']}, 03:49:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'talos_options': ['--xperf_path', 03:49:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:15 INFO - 'tests': ['tp5n']}, 03:49:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:49:15 INFO - 'talos_options': ['--e10s', 03:49:15 INFO - '--xperf_path', 03:49:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:49:15 INFO - 'tests': ['tp5n']}}, 03:49:15 INFO - 'talos.zip': {'path': '', 03:49:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:49:15 INFO - Running post-action listener: _resource_record_post_action 03:49:15 INFO - ##### 03:49:15 INFO - ##### Running create-virtualenv step. 03:49:15 INFO - ##### 03:49:15 INFO - Running pre-action listener: _resource_record_pre_action 03:49:15 INFO - Running main action method: create_virtualenv 03:49:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:49:15 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 03:49:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:49:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:49:15 INFO - Using real prefix '/usr' 03:49:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:49:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:18 INFO - Installing pip.................done. 03:49:18 INFO - Return code: 0 03:49:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:18 INFO - Using env: {'DISPLAY': ':0', 03:49:18 INFO - 'HOME': '/home/cltbld', 03:49:18 INFO - 'LANG': 'en_US.UTF-8', 03:49:18 INFO - 'LANGUAGE': 'en_US:en', 03:49:18 INFO - 'LOGNAME': 'cltbld', 03:49:18 INFO - 'MAIL': '/var/mail/cltbld', 03:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:18 INFO - 'MOZ_NO_REMOTE': '1', 03:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:18 INFO - 'NO_EM_RESTART': '1', 03:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:18 INFO - 'PWD': '/builds/slave/test', 03:49:18 INFO - 'SHELL': '/bin/bash', 03:49:18 INFO - 'SHLVL': '1', 03:49:18 INFO - 'TERM': 'linux', 03:49:18 INFO - 'TMOUT': '86400', 03:49:18 INFO - 'USER': 'cltbld', 03:49:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:18 INFO - '_': '/tools/buildbot/bin/python'} 03:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:49:18 INFO - Cleaning up... 03:49:18 INFO - Return code: 0 03:49:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:18 INFO - Using env: {'DISPLAY': ':0', 03:49:18 INFO - 'HOME': '/home/cltbld', 03:49:18 INFO - 'LANG': 'en_US.UTF-8', 03:49:18 INFO - 'LANGUAGE': 'en_US:en', 03:49:18 INFO - 'LOGNAME': 'cltbld', 03:49:18 INFO - 'MAIL': '/var/mail/cltbld', 03:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:18 INFO - 'MOZ_NO_REMOTE': '1', 03:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:18 INFO - 'NO_EM_RESTART': '1', 03:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:18 INFO - 'PWD': '/builds/slave/test', 03:49:18 INFO - 'SHELL': '/bin/bash', 03:49:18 INFO - 'SHLVL': '1', 03:49:18 INFO - 'TERM': 'linux', 03:49:18 INFO - 'TMOUT': '86400', 03:49:18 INFO - 'USER': 'cltbld', 03:49:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:18 INFO - '_': '/tools/buildbot/bin/python'} 03:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:18 INFO - Downloading/unpacking psutil>=0.7.1 03:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:20 INFO - Installing collected packages: psutil 03:49:20 INFO - Running setup.py install for psutil 03:49:20 INFO - building 'psutil._psutil_linux' extension 03:49:20 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 03:49:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:49:21 INFO - building 'psutil._psutil_posix' extension 03:49:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:49:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:21 INFO - Successfully installed psutil 03:49:21 INFO - Cleaning up... 03:49:21 INFO - Return code: 0 03:49:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:49:21 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')]} 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:21 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')]} 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:21 INFO - Using env: {'DISPLAY': ':0', 03:49:21 INFO - 'HOME': '/home/cltbld', 03:49:21 INFO - 'LANG': 'en_US.UTF-8', 03:49:21 INFO - 'LANGUAGE': 'en_US:en', 03:49:21 INFO - 'LOGNAME': 'cltbld', 03:49:21 INFO - 'MAIL': '/var/mail/cltbld', 03:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:21 INFO - 'MOZ_NO_REMOTE': '1', 03:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:21 INFO - 'NO_EM_RESTART': '1', 03:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:21 INFO - 'PWD': '/builds/slave/test', 03:49:21 INFO - 'SHELL': '/bin/bash', 03:49:21 INFO - 'SHLVL': '1', 03:49:21 INFO - 'TERM': 'linux', 03:49:21 INFO - 'TMOUT': '86400', 03:49:21 INFO - 'USER': 'cltbld', 03:49:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:21 INFO - '_': '/tools/buildbot/bin/python'} 03:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:49:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:49:23 INFO - Installing collected packages: mozsystemmonitor 03:49:23 INFO - Running setup.py install for mozsystemmonitor 03:49:23 INFO - Successfully installed mozsystemmonitor 03:49:23 INFO - Cleaning up... 03:49:23 INFO - Return code: 0 03:49:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:49:23 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')]} 03:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 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')]} 03:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:23 INFO - Using env: {'DISPLAY': ':0', 03:49:23 INFO - 'HOME': '/home/cltbld', 03:49:23 INFO - 'LANG': 'en_US.UTF-8', 03:49:23 INFO - 'LANGUAGE': 'en_US:en', 03:49:23 INFO - 'LOGNAME': 'cltbld', 03:49:23 INFO - 'MAIL': '/var/mail/cltbld', 03:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:23 INFO - 'MOZ_NO_REMOTE': '1', 03:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:23 INFO - 'NO_EM_RESTART': '1', 03:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:23 INFO - 'PWD': '/builds/slave/test', 03:49:23 INFO - 'SHELL': '/bin/bash', 03:49:23 INFO - 'SHLVL': '1', 03:49:23 INFO - 'TERM': 'linux', 03:49:23 INFO - 'TMOUT': '86400', 03:49:23 INFO - 'USER': 'cltbld', 03:49:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:23 INFO - '_': '/tools/buildbot/bin/python'} 03:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:49:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:26 INFO - Downloading docopt-0.6.1.tar.gz 03:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:26 INFO - Running setup.py install for blobuploader 03:49:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:49:26 INFO - Running setup.py install for requests 03:49:26 INFO - Running setup.py install for docopt 03:49:26 INFO - Successfully installed blobuploader requests docopt 03:49:26 INFO - Cleaning up... 03:49:26 INFO - Return code: 0 03:49:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 03:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 03:49:26 INFO - Using env: {'DISPLAY': ':0', 03:49:26 INFO - 'HOME': '/home/cltbld', 03:49:26 INFO - 'LANG': 'en_US.UTF-8', 03:49:26 INFO - 'LANGUAGE': 'en_US:en', 03:49:26 INFO - 'LOGNAME': 'cltbld', 03:49:26 INFO - 'MAIL': '/var/mail/cltbld', 03:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:26 INFO - 'MOZ_NO_REMOTE': '1', 03:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:26 INFO - 'NO_EM_RESTART': '1', 03:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:26 INFO - 'PWD': '/builds/slave/test', 03:49:26 INFO - 'SHELL': '/bin/bash', 03:49:26 INFO - 'SHLVL': '1', 03:49:26 INFO - 'TERM': 'linux', 03:49:26 INFO - 'TMOUT': '86400', 03:49:26 INFO - 'USER': 'cltbld', 03:49:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:26 INFO - '_': '/tools/buildbot/bin/python'} 03:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:27 INFO - Running setup.py (path:/tmp/pip-QvMiqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:27 INFO - Running setup.py (path:/tmp/pip-Nl4Kd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:27 INFO - Running setup.py (path:/tmp/pip-dbptut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:27 INFO - Running setup.py (path:/tmp/pip-UC0gul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:27 INFO - Running setup.py (path:/tmp/pip-kG5qOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:27 INFO - Running setup.py (path:/tmp/pip-lklhJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:27 INFO - Running setup.py (path:/tmp/pip-L4OGQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:27 INFO - Running setup.py (path:/tmp/pip-NSLfvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:27 INFO - Running setup.py (path:/tmp/pip-1Xsr5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:27 INFO - Running setup.py (path:/tmp/pip-9M4psx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:27 INFO - Running setup.py (path:/tmp/pip-eHXo9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:27 INFO - Running setup.py (path:/tmp/pip-NaXd8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:28 INFO - Running setup.py (path:/tmp/pip-1wLu5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:28 INFO - Running setup.py (path:/tmp/pip-_bbUVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:28 INFO - Running setup.py (path:/tmp/pip-efmZla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:28 INFO - Running setup.py (path:/tmp/pip-4N4dKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:28 INFO - Running setup.py (path:/tmp/pip-cyP9kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:28 INFO - Running setup.py install for manifestparser 03:49:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:49:28 INFO - Running setup.py install for mozcrash 03:49:28 INFO - Running setup.py install for mozdebug 03:49:28 INFO - Running setup.py install for mozdevice 03:49:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:49:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:49:28 INFO - Running setup.py install for mozfile 03:49:28 INFO - Running setup.py install for mozhttpd 03:49:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:49:28 INFO - Running setup.py install for mozinfo 03:49:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for mozInstall 03:49:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for mozleak 03:49:29 INFO - Running setup.py install for mozlog 03:49:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for moznetwork 03:49:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for mozprocess 03:49:29 INFO - Running setup.py install for mozprofile 03:49:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for mozrunner 03:49:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:49:29 INFO - Running setup.py install for mozscreenshot 03:49:29 INFO - Running setup.py install for moztest 03:49:30 INFO - Running setup.py install for mozversion 03:49:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:49:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:30 INFO - Cleaning up... 03:49:30 INFO - Return code: 0 03:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:30 INFO - Using env: {'DISPLAY': ':0', 03:49:30 INFO - 'HOME': '/home/cltbld', 03:49:30 INFO - 'LANG': 'en_US.UTF-8', 03:49:30 INFO - 'LANGUAGE': 'en_US:en', 03:49:30 INFO - 'LOGNAME': 'cltbld', 03:49:30 INFO - 'MAIL': '/var/mail/cltbld', 03:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:30 INFO - 'MOZ_NO_REMOTE': '1', 03:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:30 INFO - 'NO_EM_RESTART': '1', 03:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:30 INFO - 'PWD': '/builds/slave/test', 03:49:30 INFO - 'SHELL': '/bin/bash', 03:49:30 INFO - 'SHLVL': '1', 03:49:30 INFO - 'TERM': 'linux', 03:49:30 INFO - 'TMOUT': '86400', 03:49:30 INFO - 'USER': 'cltbld', 03:49:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:30 INFO - '_': '/tools/buildbot/bin/python'} 03:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:49:30 INFO - Running setup.py (path:/tmp/pip-OqMcxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:49:30 INFO - Running setup.py (path:/tmp/pip-pxTXaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:49:30 INFO - Running setup.py (path:/tmp/pip-wQzsqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:49:30 INFO - Running setup.py (path:/tmp/pip-4nwuRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:49:30 INFO - Running setup.py (path:/tmp/pip-S2YCTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:49:30 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)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:49:30 INFO - Running setup.py (path:/tmp/pip-cgTYT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:49:30 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)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:49:30 INFO - Running setup.py (path:/tmp/pip-u5WdRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:49:30 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)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:49:30 INFO - Running setup.py (path:/tmp/pip-sF6_hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:49:30 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)) 03:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:49:30 INFO - Running setup.py (path:/tmp/pip-zQQhRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:49:31 INFO - Running setup.py (path:/tmp/pip-rPnvEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:49:31 INFO - Running setup.py (path:/tmp/pip-xh0TWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:49:31 INFO - Running setup.py (path:/tmp/pip-Th9p4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:49:31 INFO - Running setup.py (path:/tmp/pip-ivNwRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:49:31 INFO - Running setup.py (path:/tmp/pip-JsHKwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:31 INFO - Running setup.py (path:/tmp/pip-ltR9iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:49:31 INFO - Running setup.py (path:/tmp/pip-7kNllY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:49:31 INFO - Running setup.py (path:/tmp/pip-7wBVhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:49:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:33 INFO - Downloading blessings-1.6.tar.gz 03:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:33 INFO - Installing collected packages: blessings 03:49:33 INFO - Running setup.py install for blessings 03:49:33 INFO - Successfully installed blessings 03:49:33 INFO - Cleaning up... 03:49:33 INFO - Return code: 0 03:49:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:49:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:33 INFO - Reading from file tmpfile_stdout 03:49:33 INFO - Current package versions: 03:49:33 INFO - argparse == 1.2.1 03:49:33 INFO - blessings == 1.6 03:49:33 INFO - blobuploader == 1.2.4 03:49:33 INFO - docopt == 0.6.1 03:49:33 INFO - manifestparser == 1.1 03:49:33 INFO - mozInstall == 1.12 03:49:33 INFO - mozcrash == 0.16 03:49:33 INFO - mozdebug == 0.1 03:49:33 INFO - mozdevice == 0.48 03:49:33 INFO - mozfile == 1.2 03:49:33 INFO - mozhttpd == 0.7 03:49:33 INFO - mozinfo == 0.9 03:49:33 INFO - mozleak == 0.1 03:49:33 INFO - mozlog == 3.1 03:49:33 INFO - moznetwork == 0.27 03:49:33 INFO - mozprocess == 0.22 03:49:33 INFO - mozprofile == 0.28 03:49:33 INFO - mozrunner == 6.11 03:49:33 INFO - mozscreenshot == 0.1 03:49:33 INFO - mozsystemmonitor == 0.0 03:49:33 INFO - moztest == 0.7 03:49:33 INFO - mozversion == 1.4 03:49:33 INFO - psutil == 3.1.1 03:49:33 INFO - requests == 1.2.3 03:49:33 INFO - wsgiref == 0.1.2 03:49:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:49: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')]} 03:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49: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')]} 03:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:33 INFO - Using env: {'DISPLAY': ':0', 03:49:33 INFO - 'HOME': '/home/cltbld', 03:49:33 INFO - 'LANG': 'en_US.UTF-8', 03:49:33 INFO - 'LANGUAGE': 'en_US:en', 03:49:33 INFO - 'LOGNAME': 'cltbld', 03:49:33 INFO - 'MAIL': '/var/mail/cltbld', 03:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:33 INFO - 'MOZ_NO_REMOTE': '1', 03:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:33 INFO - 'NO_EM_RESTART': '1', 03:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:33 INFO - 'PWD': '/builds/slave/test', 03:49:33 INFO - 'SHELL': '/bin/bash', 03:49:33 INFO - 'SHLVL': '1', 03:49:33 INFO - 'TERM': 'linux', 03:49:33 INFO - 'TMOUT': '86400', 03:49:33 INFO - 'USER': 'cltbld', 03:49:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:33 INFO - '_': '/tools/buildbot/bin/python'} 03:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:49:34 INFO - Cleaning up... 03:49:34 INFO - Return code: 0 03:49:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:34 INFO - Using env: {'DISPLAY': ':0', 03:49:34 INFO - 'HOME': '/home/cltbld', 03:49:34 INFO - 'LANG': 'en_US.UTF-8', 03:49:34 INFO - 'LANGUAGE': 'en_US:en', 03:49:34 INFO - 'LOGNAME': 'cltbld', 03:49:34 INFO - 'MAIL': '/var/mail/cltbld', 03:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:34 INFO - 'MOZ_NO_REMOTE': '1', 03:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:34 INFO - 'NO_EM_RESTART': '1', 03:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:34 INFO - 'PWD': '/builds/slave/test', 03:49:34 INFO - 'SHELL': '/bin/bash', 03:49:34 INFO - 'SHLVL': '1', 03:49:34 INFO - 'TERM': 'linux', 03:49:34 INFO - 'TMOUT': '86400', 03:49:34 INFO - 'USER': 'cltbld', 03:49:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:34 INFO - '_': '/tools/buildbot/bin/python'} 03:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:34 INFO - Downloading/unpacking jsonschema 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:36 INFO - Downloading/unpacking functools32 (from jsonschema) 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:36 INFO - warning: no files found matching '*.txt' 03:49:36 INFO - no previously-included directories found matching 'build' 03:49:36 INFO - no previously-included directories found matching 'dist' 03:49:36 INFO - no previously-included directories found matching '.git*' 03:49:36 INFO - Installing collected packages: jsonschema, functools32 03:49:36 INFO - Running setup.py install for functools32 03:49:36 INFO - warning: no files found matching '*.txt' 03:49:36 INFO - no previously-included directories found matching 'build' 03:49:36 INFO - no previously-included directories found matching 'dist' 03:49:36 INFO - no previously-included directories found matching '.git*' 03:49:36 INFO - Successfully installed jsonschema functools32 03:49:36 INFO - Cleaning up... 03:49:36 INFO - Return code: 0 03:49:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7fda62715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17df8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ac3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', '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 03:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 03:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 03:49:36 INFO - Using env: {'DISPLAY': ':0', 03:49:36 INFO - 'HOME': '/home/cltbld', 03:49:36 INFO - 'LANG': 'en_US.UTF-8', 03:49:36 INFO - 'LANGUAGE': 'en_US:en', 03:49:36 INFO - 'LOGNAME': 'cltbld', 03:49:36 INFO - 'MAIL': '/var/mail/cltbld', 03:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:36 INFO - 'MOZ_NO_REMOTE': '1', 03:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:36 INFO - 'NO_EM_RESTART': '1', 03:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:36 INFO - 'PWD': '/builds/slave/test', 03:49:36 INFO - 'SHELL': '/bin/bash', 03:49:36 INFO - 'SHLVL': '1', 03:49:36 INFO - 'TERM': 'linux', 03:49:36 INFO - 'TMOUT': '86400', 03:49:36 INFO - 'USER': 'cltbld', 03:49:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:36 INFO - '_': '/tools/buildbot/bin/python'} 03:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:36 INFO - Downloading/unpacking flake8 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:49:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:49:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:49:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:39 INFO - no previously-included directories found matching 'docs/_build' 03:49:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:49:39 INFO - Running setup.py install for pep8 03:49:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:39 INFO - no previously-included directories found matching 'docs/_build' 03:49:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:49:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:49:39 INFO - Cleaning up... 03:49:39 INFO - Return code: 0 03:49:39 INFO - Running post-action listener: _resource_record_post_action 03:49:39 INFO - Running post-action listener: _start_resource_monitoring 03:49:39 INFO - Starting resource monitoring. 03:49:39 INFO - ##### 03:49:39 INFO - ##### Running install step. 03:49:39 INFO - ##### 03:49:39 INFO - Running pre-action listener: _resource_record_pre_action 03:49:39 INFO - Running main action method: install 03:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:49:39 INFO - Reading from file tmpfile_stdout 03:49:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:49:39 INFO - Reading from file tmpfile_stdout 03:49:39 INFO - Output received: 03:49:39 INFO - Usage: mozinstall [options] installer 03:49:39 INFO - Options: 03:49:39 INFO - -h, --help show this help message and exit 03:49:39 INFO - -d DEST, --destination=DEST 03:49:39 INFO - Directory to install application into. [default: 03:49:39 INFO - "/builds/slave/test"] 03:49:39 INFO - --app=APP Application being installed. [default: firefox] 03:49:39 INFO - mkdir: /builds/slave/test/build/application 03:49:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:49:55 INFO - Reading from file tmpfile_stdout 03:49:55 INFO - Output received: 03:49:55 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:55 INFO - Running post-action listener: _resource_record_post_action 03:49:55 INFO - ##### 03:49:55 INFO - ##### Running run-tests step. 03:49:55 INFO - ##### 03:49:55 INFO - Running pre-action listener: _resource_record_pre_action 03:49:55 INFO - Running main action method: run_tests 03:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:55 INFO - Python 2.7.3 03:49:55 INFO - Return code: 0 03:49:55 INFO - grabbing minidump binary from tooltool 03:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193b100>, '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 0x193c000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193c490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:49:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:49:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:55 INFO - Return code: 0 03:49:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:49:56 INFO - Return code: 0 03:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:49:56 INFO - Using env: {'DISPLAY': ':0', 03:49:56 INFO - 'HOME': '/home/cltbld', 03:49:56 INFO - 'LANG': 'en_US.UTF-8', 03:49:56 INFO - 'LANGUAGE': 'en_US:en', 03:49:56 INFO - 'LOGNAME': 'cltbld', 03:49:56 INFO - 'MAIL': '/var/mail/cltbld', 03:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:56 INFO - 'MOZ_NO_REMOTE': '1', 03:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:56 INFO - 'NO_EM_RESTART': '1', 03:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:56 INFO - 'PWD': '/builds/slave/test', 03:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:56 INFO - 'SHELL': '/bin/bash', 03:49:56 INFO - 'SHLVL': '1', 03:49:56 INFO - 'TERM': 'linux', 03:49:56 INFO - 'TMOUT': '86400', 03:49:56 INFO - 'USER': 'cltbld', 03:49:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319', 03:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:56 INFO - '_': '/tools/buildbot/bin/python'} 03:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:49:57 INFO - mozversion application_buildid: 20160301022840 03:49:57 INFO - mozversion application_changeset: 1c87ce4424478e99539f4b054ba0e6b0576ce8ec 03:49:57 INFO - mozversion application_display_name: Nightly 03:49:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:57 INFO - mozversion application_name: Firefox 03:49:57 INFO - mozversion application_remotingname: firefox 03:49:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:49:57 INFO - mozversion application_vendor: Mozilla 03:49:57 INFO - mozversion application_version: 47.0a1 03:49:57 INFO - mozversion platform_buildid: 20160301022840 03:49:57 INFO - mozversion platform_changeset: 1c87ce4424478e99539f4b054ba0e6b0576ce8ec 03:49:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:49:57 INFO - mozversion platform_version: 47.0a1 03:49:57 INFO - using testdate: 1456832997 03:49:57 INFO - actual date: 1456832997 03:49:57 INFO - starting webserver on 'localhost:56688' 03:49:57 INFO - SUITE-START | Running 2 tests 03:49:57 INFO - TEST-START | dromaeo_css 03:49:57 INFO - operating with platform_type : linux_ 03:49:57 INFO - Initialising browser for dromaeo_css test... 03:49:57 INFO - TEST-INFO | started process 23264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPFLw5x/profile http://localhost:56688/getInfo.html) 03:50:00 INFO - PROCESS | 23264 | 03:50:00 INFO - PROCESS | 23264 | (process:23346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:50:01 INFO - PROCESS | 23264 | __metrics Screen width/height:1600/1200 03:50:01 INFO - PROCESS | 23264 | colorDepth:24 03:50:01 INFO - PROCESS | 23264 | Browser inner width/height: 1024/697 03:50:01 INFO - PROCESS | 23264 | __metrics 03:50:02 ERROR - PROCESS | 23264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - PROCESS | 23264 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 03:50:02 INFO - TEST-INFO | 23264: exit 0 03:50:02 INFO - Browser initialized. 03:50:02 INFO - Running cycle 1/1 for dromaeo_css test... 03:50:02 INFO - TEST-INFO | started process 23397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPFLw5x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:04 INFO - PROCESS | 23397 | 03:50:04 INFO - PROCESS | 23397 | (process:23453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:50:14 INFO - PROCESS | 23397 | RSS: Main: 160763904 03:50:14 INFO - PROCESS | 23397 | 03:51:04 INFO - PROCESS | 23397 | 1456833064570 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] 03:53:15 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56688/tests/dromaeo/cssquery-ext.html) 03:53:16 INFO - PROCESS | 23397 | RSS: Main: 169611264 03:53:16 INFO - PROCESS | 23397 | 03:56:18 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-ext.html (next: http://localhost:56688/tests/dromaeo/cssquery-jquery.html) 03:56:18 INFO - PROCESS | 23397 | RSS: Main: 165421056 03:56:18 INFO - PROCESS | 23397 | 03:59:20 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56688/tests/dromaeo/cssquery-mootools.html) 03:59:21 INFO - PROCESS | 23397 | RSS: Main: 166723584 03:59:21 INFO - PROCESS | 23397 | 04:02:22 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56688/tests/dromaeo/cssquery-prototype.html) 04:02:23 INFO - PROCESS | 23397 | RSS: Main: 164118528 04:02:23 INFO - PROCESS | 23397 | 04:05:26 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56688/tests/dromaeo/cssquery-yui.html) 04:05:26 INFO - PROCESS | 23397 | RSS: Main: 163831808 04:05:26 INFO - PROCESS | 23397 | 04:08:28 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:56688/tests/dromaeo/cssquery-yui.html (next: http://localhost:56688/tests/dromaeo/cssquery-dojo.html) 04:08:29 INFO - PROCESS | 23397 | RSS: Main: 167825408 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | __start_tp_report 04:08:29 INFO - PROCESS | 23397 | _x_x_mozilla_page_load 04:08:29 INFO - PROCESS | 23397 | _x_x_mozilla_page_load_details 04:08:29 INFO - PROCESS | 23397 | |i|pagename|runs| 04:08:29 INFO - PROCESS | 23397 | |0;dojo.html;2622.331305517093;2660.321617987413;2690.5695088785797;2697.473992571448;2710.7424794644503;4491.595756381925;4635.258358662611;4658.394408726861;4690.413698287714;4728.55078767517;4536.546345365462;4617.353570500132;4686.133065382906;4697.295405689139;4775.665703400763;4253.25568025595;4316.633086187662;4330.783460826962;4332;4332.06860524987;95.95051718846436;4258.212230737324;4308.849190278341;4331.177076355498;4353;4307.375430562583;4313.331433627793;4315.029118448356;4342.739435633872;4349.739015659071;4166.166766646653;4290.570942905716;4311.698181127323;4330.372096046087;4378.846740364072;4183.330667093281;4238.978805105986;4244.8514301999285;4258.8509402171085;4276.978615106936;4542.182407166709;4555.293929440942;4560.612347950395;4598.747068911209;4615.653825963032;4783.1868582341085;4947.703137811743;4948.356713627241;4953.950460495421;4977.029479251547;4939.481354457802;4942.728149951788;4962.6774259673;4980.501949805027;4994.87512812179;4609.469910960249;4610.561996610317;4612.331211974312;4639.86080417588;4655.3947986761505;4912.631552633567;5054.620903432257;5057.8229761958155;5113.642045056885;5187.740612969336;4867.3915760529935;4890.682105663121;4931.7040977541465;4939.975300123477;4958.429780575208;5015.874603134878;5024.371953505812;5028.823991160292;5033.3205017322925;5033.723145226974;4769.9046019080115;4901.901961960741;4984.053029924303;5004.449510553836;5023.321851549994;4707.082118986833;4879.2925025871045;4953.2570114483115;4967.528084831935;5009.849704508871;4138.627523522898;4185.748855068706;4188.099558594917;4217.746935183899;4227.852025179104;3561.5370001899587;3580.3913334733156;3640.7269454790467;3671.4492826076303;3671.7980511071614;4315.093830295673;4318.654507639381;4323.3947247385395;4324.740515569076;4326.459192600925;4934.703917764946;4940.777665005084;4972.57733092684;4995.475475075137;5020.046191223656;4216.620504154641;4261.914761704748;4326.069894972596;4346.326319420495;4367.344898265222;4341.0666706657585;4389.934150987738;4394.890127746832;4413.073254616566;4423.358613001097;4655.813767449332;4661.324108004321;4662.790174442091;4683.367745354333;4700.600448961876;4969.503049695001;5001.1498045331655;5010.148274793221;5022.698638081727;5062.873428164326;4717.952820471889;4720.551547602972;4720.834770783006;4722.386089808303;4733.479317275166;4729.834455794031;4912.95087049125;4933.457319694902;4972.428170760409;4994.850154495371;4949.975250123726;4965.97517012427;4972.179590367694;4990.80036798524;5030.245463180406;4847.248676455155;4851.927221091616;4855.1988921828915;4860.538248866352;4861.149298872754;4653.488116307136;4805.5915247204375;4886.071646387317;4895.485973972682;4899.240617704261;4586.931196031996;4649.604783593432;4670.813167473263;4684.297355396718;4712.010477799563;4850.854474365775;4863.683860549053;4932.654714169974;4934.383202099738;4984.302197692398;4622.86131416058;4811.7834697438;4820.1805693031565;4820.975895120502;4827.396575428072 04:08:29 INFO - PROCESS | 23397 | |1;ext.html;483.7097741355187;500.40701768404443;506.1648280337443;529.8993191293652;531.8484231993882;32153.19617009573;33118.83440582794;33274.500882486755;33341.16647083821;33382.49926251108;37280.06799830006;37547.4367884482;37549.24901501968;37629;37706;7660.195679453646;7773.766786996399;7778.533288002738;7784.987951566289;7845.37237021037;7710.653020614058;7776.339011184028;7796.064472263336;7799.415043871732;7802.8439431211345;7919.8416031679335;7964.2433968772875;7976.162502937195;7978;8014.919850801476;7954.681812727484;7964.084130325;7980.800479987989;7983.840323193533;8010.158933312035;7497.2877576630135;7569.886451703229;7573.659185336673;7609.619519024082;7624.27569380908;36917.261654767026;37457.25085498302;37470.812645936865;37516.24967500662;37531.06172345713;2194.8024677779076;2805.5931889875856;2915.9271018224504;3086.9536956945662;3189.728873045794;24352.147674831474;24382.634260486106;24577.87711061451;24821.1312604058;24853.25440236796;2863.21261653045;2897.739203471677;2911.4613796447725;2921.8977335793147;2951.5425109108123;143649;143875.28062359727;144093;144893;144967.27516362455;50242.497575024514;50351.74824125856;50440;50654.49345506498;50824.74587627038;53121;53307.46692533103;58510;60059;60195;12190.2076365036;12225.083118766128;12380.195287306477;12397.566085186974;12420;8366.665333386718;8389.790255243546;8524.659013639384;8542.487450752975;8580.099089595627;18014.279428822963;18250.634987300444;18283;18363;18597.907010465133;7248.818779530448;7827.6477558510005;7881.645325960346;7950.3242224410415;8076.919230807616;894.4186278918755;924.5562130177552;934.6962237272913;948.8529277961927;1068.893110688925;25540.616890746653;26171.211865500667;26183.73816261813;26502;26610.06864759724;951.9571619277149;989.2975987049275;1014.7767491151935;1025.436010194405;1101.9173561982884;13558.050936434354;13568.457261709422;13884.930575347058;13900.165990040428;13980.51068212628;253501;253947;254252;255666;257184;45345.31982020273;45944.54055459469;46120;46241.30638040432;46325;1177.328922514176;1204.8192771084232;1209.5929101088946;1209.776191404593;1218.3360068762368;24829;25408.745912541377;25638.487230255665;25793.226203213933;26300.342491437867;40254.79872600736;40266.1946761069;40387.79806101068;40590.79704601458;40715.38926916158;240742;241801;243467;244218;244582;28979.710202897702;29539.704602953694;29712.70287297186;30121.09636710902;30147.547786782776;38442.80778596089;38587.807060964515;38757.41863872101;39081.218375632896;39476.80261598789;32214.67785322117;32508.674913250565;33050;33180;33446.832765836014;32936;33487.66512334943;33633.495497568045;33708.988730338126;33747.325053499284;26711;32316.83841580777;32643.18392040123;33408.498872516444;34303.313933721685;27933.301667457665;28992.565111523767;29197.562036569045;29221.269468263465;29500.704992949795;22676;22724.20465283707;22876;22947.77052229523;22994.770052299933 04:08:29 INFO - PROCESS | 23397 | |2;jquery.html;323.83808095952025;333.889816360601;338.949157626356;339.8487672985522;341;14700.632484187901;15131.697366052673;15686.843131568681;15697.372105115795;15709.921450392761;14302.35639396227;14543.3455494503;14822.703545929102;14951.626209344771;14954.476593319236;5034.572061374787;5133;5191.117510023286;5191.351081114861;5215.295935048758;5053.292539044537;5060.9493905060845;5095.388553373582;5100.183970564711;5105.84682459525;4936.284238785374;5014.272930425086;5015.172496538067;5088.7964481420695;5102.948970510303;4921.507849215086;5042.84871453857;5056.873578160557;5086.97456512717;5138.409082955471;4879.341288926021;4913.975430122862;4940.925886111711;4959.776810043557;4968.652194346397;11155.888441115567;11172.385518796464;11379.203455758101;11776.41117944108;11823.231489953125;1812.673718730628;1818.9181486833124;1941.0682872221412;2175.4996350839237;2178.9323231616554;10359.948200259027;12100.576479823163;12617.495300187982;12647.177933434297;12927.353632318347;1694.4577735124642;1714.4085290574733;1785.366195000769;1791.5073354827396;1834.5146117742127;38406.80796596027;48221.75889120532;51656;53575.464245357434;55440.44559554433;9458.196053335407;9470.90529094714;9508.714738557715;9547.761305967406;9607.615695372107;12236.81644775329;12304.569340073054;12322.753544929052;12386;12388.62834114978;6332.176817013758;6338.904916426257;6586.835329116715;6679.3320667933785;6700.095487109178;6204.844878877974;6212.9378706213265;6237.625742455376;6305.243370795442;6305.779297724557;4086.6730661547003;4121.340585506305;4145.067359844072;4236.152769446123;4256.8297268109545;1693.7798086248708;1756.4116021133063;1761.7005109131478;1779.5817982774038;1779.9288028478975;891.2914233184633;894.7271082319825;920.2867777472512;923.8290916180393;991.6380521109887;15118.470853520073;15449;15527.378904843905;15714.9214253928;16013.119278439797;862.6032025268321;890.3678388344348;912.5847739278612;932.3659911260409;932.5057719408725;8820;8903.33225008127;8904.643814247487;8953.462792232487;9056.773580660536;256914;261343;263770;347080;357290;58014.419855801745;59488.70255648694;59700.402995970355;64618.67690661517;69398.65300673465;930.7393929699559;958.8417911044878;963.6964356227905;973.6154219083422;975.7560609847538;14227.50203742864;14369.425222991382;14456.566303010926;14619;14767.335469903664;21216.363509094135;29740.405191895607;30958.38083238368;32170;32226;41039;44748.32877506775;44930.32604511001;45074.098518030114;45119.548804511534;6726.730930762715;6894.551854129466;6924.480663950123;6969.756058537927;7007.894881576883;8468.407211495383;9796.51017449139;9815.950920245354;9826.55780489894;10031.448270345201;8169.104725130378;8462.788430289293;8692.652293908173;8957.955210223907;9039.548022598976;8621.8706719398;8696.56517174126;8700.56497175126;8958.238549723346;9048.41185322952;8872.689455869013;8888.51113188755;9419.587061940763;9554.04459554039;9875.753106172404;7017.333353331425;7037.683304251424;7058.576485410892;7168.283171682999;7169.211386747349;8772.342074344322;8847.911520884709;9046.140616641409;9076.228520575825;9248 04:08:29 INFO - PROCESS | 23397 | |3;mootools.html;1341.7316536692663;1348.0563605476166;1452.2956366162416;1688.696034713751;1707.1123016031656;5865.677387743673;6906.033155358254;7016.228214896364;7160.856782864346;7223.855522889546;6769.4584433245345;6831.316868313166;6847.9385695217325;6852.7944161675105;6867.725290988355;2039.8470114741417;2056.1878058167017;2065.401033700225;2071.2543484345624;2073.792620737929;2026.3009261804655;2034.1354924157247;2037.9490512737227;2113.228671534894;2115.122224276931;2039.6022775558772;2059.618970490464;2063.174730107954;2077.096463038583;2082.4377418097106;2054.989725051365;2055.599158164159;2062.845286603511;2067.8138967492923;2070.4099331690545;2011.4770159758423;2030.3198428526314;2091.278508914422;2095.0991073838245;2096.7693553709078;6987.685554150075;7057.153141623038;7058.400035996947;7065.293470652894;7087.681054352515;4232.957670423287;4366.607005369532;4369.868903932887;4370.890727731832;4393.406890069831;2563.064481464252;2634.7233540478164;2679.6114563388396;2702.90539831105;2702.9053983110693;794.7575989323254;820.9753707388788;821.4988856797349;824.3034635732796;1507.3443052272296;9371.156595906334;9384.390014649027;9462.290328225341;9483.90516094837;9503.57233924475;3689.446583012516;3788.1476667749534;3835;3840.9423858642144;3869.6517313441927;7570.091589009354;7579.772606821804;7605.543667379864;7611.314981651678;7624.961875190588;4218.325067989107;4232.91534169321;4241.427407299975;4241.830326786956;4260.893477663083;3140.0736782649174;3696.74122811406;3757.5490941087246;3850.133719913053;3857.2478366718783;3105.2547388627017;3160.3995240904155;3196.2329041030453;3196.5524826524306;3220.6940340667597;934.4393363981557;964.8070385922844;965.830979578585;967.3615413826841;979.4612962870535;854.2994744309731;862.3316929379781;864.1962974433711;869.1569177897429;1092.5083712329324;6646.401823835781;6702.631355275409;6720.764773232913;6773.491988100814;6788.287229840895;426.5244252658264;428.15653163268314;430.58663682864176;431.4714474768446;449.05025870284766;5290.81482148123;5366.168243922199;5375.220593013991;5380.381256155514;5404.945950540444;8102.716404925917;8324.791880203044;8331.95834020826;8448.450850694686;8718;8242.752717418487;8312.41813073079;8318.70884519039;8327.084020757833;8365.539895305696;6542.8364290893105;6592.736290548421;6624.6025238485845;6660.267370589231;6759.2226893906845;6544.5418820684;6609.239937407067;6631.33686631333;6673.432758215606;6692.59844409337;7543.0948286206;7628.46600737943;7815.062192536705;7915.683372665029;7948.046234451672;7679.769606911802;7995.360371170176;8037.115917249215;8049.476784009021;8057.798555036171;5513.779448822002;6450.129232553733;6763;6897.793066208022;6915.343042410963;6747.190337159376;6761;6778.593284402951;6792.286809884891;6812.557183783237;5803.912941305968;6093.146959425595;6094.603850749687;6184.5980011299125;6217.626942383471;5921.85195370102;6106.053561697944;6166.414190651881;6210.72051757681;6211.596246243979;6501.44737697301;6519;6524.314946930694;6550.410463058348;6565.901511477427;5985.371535988833;5990.88018239624;6021.307549631849;6034;6041.426064523863;5902.2327097477055;5968.194293770285;6013.579049466495;6065.968785306421;6072 04:08:29 INFO - PROCESS | 23397 | |4;prototype.html;287.79278919178194;298.2082570774594;300.88415959855456;306.1214314916191;306.15195907336664;5621.325440947087;5712.714364281785;5731.025725626649;5740.7703691852275;5829.912551311723;5627.6060675752715;5632.943670563293;5639.2668953036045;5647.265855438787;5657.830265092043;4052.797360131989;4187.497500299968;4259.659227261827;4278.2940814765525;4284.4001839742305;4239.173361194568;4255.936160957588;4272.487301523822;4307;4319.632831209336;4254.255505286578;4258.063226090255;4266.104118135196;4267.8079486423185;4300.096979634281;4267.658587313023;4272.743635381856;4276.33716773899;4281.507626622947;4287.635550978171;3757.8684746034032;3757.887263382103;3765.039914821703;3771.5097037384962;3787.6401741834484;5420.91868621971;5421.024215641183;5424.511793938565;5429.348478182604;5434.483724046209;4698.694584851974;4840.5159484051665;4865.854024379274;4925.236588328815;4935.457099719028;5911.29064512257;5929.673867937262;5939.07944268639;5955.076963070731;5972.104184372379;3956.208758248333;3973.1060511384994;3973.4834471518807;3982.6415622594104;4000.4999375078114;6183.969080154616;6286.151369565096;6286.245650521921;6287.6856157192415;6289.748410063592;4063.065494936122;4098.364753463218;4101.364288535222;4101.91796164075;4104;4149.2738770715005;4163.333866581393;4163.875083747493;4166.395872598517;4168.812403441852;4675.275332323496;4798.2802579613335;4866.732329721899;4871.244957031666;4888.388951381077;5945.554083443759;5966.224390829251;5976.193213916153;5984.820455386345;5985.9401405986255;1453.3750487290567;1457.8979471436899;1466.340146933884;1473.7789331600345;1475.063334782421;940.6895724410928;954.4082668745423;967.56943160293;979.6962941488162;980.2158273381267;5138.871528211825;5155.38135423744;5160.7935682573025;5162.070827251131;5165.483451654804;6163.96918015407;6172.537059720539;6176.4441200292185;6188.628682279078;6189.659568723673;5053.31780209667;5146.305248791366;5147.202183661539;5208.828013696888;5237.3453318335205;3352.5138854866395;3353.597568291772;3377.847996840148;3381.036404624719;3391.7117045051446;5857.20927674767;5869.031609784423;5881.853038657507;5881.882362352729;5886.793962211302;6417.1657684500715;6425.710843011982;6442.194725659293;6444.065610486547;6445.45213656835;5818.21454103699;5824.970875145597;5836.591438599342;5851.210086638334;5855.301962430933;6095.207623008981;6239.376062393906;6281.654509002049;6292.590981586182;6295.811125666238;6074.210352654127;6075.483583895419;6087.634741915499;6115.174451448997;6124.908126378197;5805.912911306418;5831.125331200354;5850.414958504116;5854.209681692917;5864.765409383747;3996.3805610130476;4043.5147782266317;4054.6958978076173;4069.369247766601;4071.877843664695;6243.875122497616;6255.061740738925;6261.74953001893;6268.874622507616;6299.527535434769;5767.9711601443405;5868.765249389977;5999.400059993965;6035.517158627387;6041.78853740117;5953.7023148843255;6010.188624535806;6019.187409699634;6023.698815059317;6032.517398608188;5890.676012819336;5892.94107058924;5898.882022359615;5907.32065812437;5909.084091965752;6003.489703375262;6033.879322413615;6043.395660434097;6054.636721796706;6057.273127224761;5759.753696058624;5832.708364581669;5884;5889.823305300848;5902.822915312548 04:08:29 INFO - PROCESS | 23397 | |5;yui.html;556.5130510803048;633.8985762278037;660.5607271164675;698.6576577477038;719.8272414620493;10751.569937202512;10953.397563134024;11038.448077596118;11041.944790276048;11054.502547385368;11135.387553684544;12337.629871103858;12698.80951785724;12707.428165732541;12782.936085319561;604.5828378418877;760.3195140349384;770.6878714120791;773.3310686256403;774.9767506974799;680.5440354962187;701.7087908517959;727.04756768633;760.9581473018982;781.1173374087302;817.6157206113147;817.963191656374;819.0785366462729;819.3117781063905;821.3552361396305;810.0279664402682;810.6109067647533;813.1380736419385;814.0069115678863;816.3958670583785;600.1118344849604;604.030530997751;604.4348534120568;606.2088973889073;608.922207692382;10330.638427654996;10426.426546539937;10488.528016239212;10489.842652360221;10552.472376381227;10731.463426828705;10803.837942430791;10959.452027398598;11076.667699969013;11089;9336.11306925841;9511;9584.5686944087;9596.184324332371;9617.807643847154;3068.8005279656973;3128.139761565565;3168.30297334586;3177.8411079445937;3179.0925444733207;43192.56807431917;43439;43996.3400548992;44047.559524404984;44143.33784993228;7990.880136797953;8063.758087257392;8122.390820688472;9234.353595248402;9371.437713737061;14931.25343732809;14937.925310373379;15019;15030.699386012218;15163.620909477351;6063.938810708109;6126.356732543108;6177.4749146322165;6245.812625621239;6326.557141000178;3580.122869896892;3600.477930700034;3654.9634503655157;3673.1551743099235;3696.667299943018;2519.6472493850874;2526.8231223814523;2543.707473640518;2544.1731437282956;2548.668673072526;473.49572705068994;476.8688610632104;478.3207844860307;480.015967267101;485.09529727059487;558.4192439862578;569.7977218087602;576.7462316580691;589.9587028907936;590.2238556298539;7168.749093781797;7187.64061796908;7218.205997340288;7276.745313913988;7447.590382528904;461.53385081068365;474.73889360851393;561.5619816543103;614.5145335185243;624.3350831364583;3362.7309815214726;3371.6291207967106;3424.2124311408515;3459.5502584664337;3523.4010218262956;49442;49931;50224;50932.49067509278;50945;43737.78131109324;43912.3413148803;44167;44594.3310850331;44616.86906005786;41113.588864111574;41921.580784192374;42318.15363692709;42792.78603606962;42836.85957685098;6821.488388370992;7040.3663670269925;7043.330883566053;7056.54132481387;7068.11648543932;32033.679663204002;32324.353512929138;32424;32642.183945401554;32682.019539413857;38764.22471550497;40374.39438408367;40435;40600.390994135705;40632.79683601563;8124.065732440608;8358.958205208935;8543.8718419225;8606.961703654326;8708.17272359125;8385.413021088465;8552.401331906707;8584.313254939465;8720.738377848675;8923.15230053144;9062.410943288665;9264.040034951191;9320.114589114024;9325.906740932503;9519.190868776232;7901.17037711032;8027.237412445808;8040.195980401913;8074;8340.708075217339;8282.792930176794;8388.706395276136;8492.91507084946;8830.249428798625;8851.867221991804;7085;7247;7326.6702998364135;7607.429442791702;7797.454178207471;7016.6491675415;7471.813204669927;7484.663190156565;7497.482151805213;7579.886301705589 04:08:29 INFO - PROCESS | 23397 | __end_tp_report 04:08:29 INFO - PROCESS | 23397 | __start_cc_report 04:08:29 INFO - PROCESS | 23397 | _x_x_mozilla_cycle_collect,345 04:08:29 INFO - PROCESS | 23397 | __end_cc_report 04:08:29 INFO - PROCESS | 23397 | __startTimestamp1456834109196__endTimestamp 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | ------- Summary: start ------- 04:08:29 INFO - PROCESS | 23397 | Number of tests: 6 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#0] dojo.html Cycles:165 Average:4566.82 Median:4700.60 stddev:588.51 (12.5%) stddev-sans-first:570.21 04:08:29 INFO - PROCESS | 23397 | Values: 2622.3 2660.3 2690.6 2697.5 2710.7 4491.6 4635.3 4658.4 4690.4 4728.6 4536.5 4617.4 4686.1 4697.3 4775.7 4253.3 4316.6 4330.8 4332.0 4332.1 96.0 4258.2 4308.8 4331.2 4353.0 4307.4 4313.3 4315.0 4342.7 4349.7 4166.2 4290.6 4311.7 4330.4 4378.8 4183.3 4239.0 4244.9 4258.9 4277.0 4542.2 4555.3 4560.6 4598.7 4615.7 4783.2 4947.7 4948.4 4954.0 4977.0 4939.5 4942.7 4962.7 4980.5 4994.9 4609.5 4610.6 4612.3 4639.9 4655.4 4912.6 5054.6 5057.8 5113.6 5187.7 4867.4 4890.7 4931.7 4940.0 4958.4 5015.9 5024.4 5028.8 5033.3 5033.7 4769.9 4901.9 4984.1 5004.4 5023.3 4707.1 4879.3 4953.3 4967.5 5009.8 4138.6 4185.7 4188.1 4217.7 4227.9 3561.5 3580.4 3640.7 3671.4 3671.8 4315.1 4318.7 4323.4 4324.7 4326.5 4934.7 4940.8 4972.6 4995.5 5020.0 4216.6 4261.9 4326.1 4346.3 4367.3 4341.1 4389.9 4394.9 4413.1 4423.4 4655.8 4661.3 4662.8 4683.4 4700.6 4969.5 5001.1 5010.1 5022.7 5062.9 4718.0 4720.6 4720.8 4722.4 4733.5 4729.8 4913.0 4933.5 4972.4 4994.9 4950.0 4966.0 4972.2 4990.8 5030.2 4847.2 4851.9 4855.2 4860.5 4861.1 4653.5 4805.6 4886.1 4895.5 4899.2 4586.9 4649.6 4670.8 4684.3 4712.0 4850.9 4863.7 4932.7 4934.4 4984.3 4622.9 4811.8 4820.2 4821.0 4827.4 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#1] ext.html Cycles:180 Average:37453.89 Median:33361.83 stddev:57378.31 (172.0%) stddev-sans-first:57472.13 04:08:29 INFO - PROCESS | 23397 | Values: 483.7 500.4 506.2 529.9 531.8 32153.2 33118.8 33274.5 33341.2 33382.5 37280.1 37547.4 37549.2 37629.0 37706.0 7660.2 7773.8 7778.5 7785.0 7845.4 7710.7 7776.3 7796.1 7799.4 7802.8 7919.8 7964.2 7976.2 7978.0 8014.9 7954.7 7964.1 7980.8 7983.8 8010.2 7497.3 7569.9 7573.7 7609.6 7624.3 36917.3 37457.3 37470.8 37516.2 37531.1 2194.8 2805.6 2915.9 3087.0 3189.7 24352.1 24382.6 24577.9 24821.1 24853.3 2863.2 2897.7 2911.5 2921.9 2951.5 143649.0 143875.3 144093.0 144893.0 144967.3 50242.5 50351.7 50440.0 50654.5 50824.7 53121.0 53307.5 58510.0 60059.0 60195.0 12190.2 12225.1 12380.2 12397.6 12420.0 8366.7 8389.8 8524.7 8542.5 8580.1 18014.3 18250.6 18283.0 18363.0 18597.9 7248.8 7827.6 7881.6 7950.3 8076.9 894.4 924.6 934.7 948.9 1068.9 25540.6 26171.2 26183.7 26502.0 26610.1 952.0 989.3 1014.8 1025.4 1101.9 13558.1 13568.5 13884.9 13900.2 13980.5 253501.0 253947.0 254252.0 255666.0 257184.0 45345.3 45944.5 46120.0 46241.3 46325.0 1177.3 1204.8 1209.6 1209.8 1218.3 24829.0 25408.7 25638.5 25793.2 26300.3 40254.8 40266.2 40387.8 40590.8 40715.4 240742.0 241801.0 243467.0 244218.0 244582.0 28979.7 29539.7 29712.7 30121.1 30147.5 38442.8 38587.8 38757.4 39081.2 39476.8 32214.7 32508.7 33050.0 33180.0 33446.8 32936.0 33487.7 33633.5 33709.0 33747.3 26711.0 32316.8 32643.2 33408.5 34303.3 27933.3 28992.6 29197.6 29221.3 29500.7 22676.0 22724.2 22876.0 22947.8 22994.8 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#2] jquery.html Cycles:180 Average:19643.03 Median:5058.91 stddev:49570.79 (979.9%) stddev-sans-first:49688.62 04:08:29 INFO - PROCESS | 23397 | Values: 323.8 333.9 338.9 339.8 341.0 14700.6 15131.7 15686.8 15697.4 15709.9 14302.4 14543.3 14822.7 14951.6 14954.5 5034.6 5133.0 5191.1 5191.4 5215.3 5053.3 5060.9 5095.4 5100.2 5105.8 4936.3 5014.3 5015.2 5088.8 5102.9 4921.5 5042.8 5056.9 5087.0 5138.4 4879.3 4914.0 4940.9 4959.8 4968.7 11155.9 11172.4 11379.2 11776.4 11823.2 1812.7 1818.9 1941.1 2175.5 2178.9 10359.9 12100.6 12617.5 12647.2 12927.4 1694.5 1714.4 1785.4 1791.5 1834.5 38406.8 48221.8 51656.0 53575.5 55440.4 9458.2 9470.9 9508.7 9547.8 9607.6 12236.8 12304.6 12322.8 12386.0 12388.6 6332.2 6338.9 6586.8 6679.3 6700.1 6204.8 6212.9 6237.6 6305.2 6305.8 4086.7 4121.3 4145.1 4236.2 4256.8 1693.8 1756.4 1761.7 1779.6 1779.9 891.3 894.7 920.3 923.8 991.6 15118.5 15449.0 15527.4 15714.9 16013.1 862.6 890.4 912.6 932.4 932.5 8820.0 8903.3 8904.6 8953.5 9056.8 256914.0 261343.0 263770.0 347080.0 357290.0 58014.4 59488.7 59700.4 64618.7 69398.7 930.7 958.8 963.7 973.6 975.8 14227.5 14369.4 14456.6 14619.0 14767.3 21216.4 29740.4 30958.4 32170.0 32226.0 41039.0 44748.3 44930.3 45074.1 45119.5 6726.7 6894.6 6924.5 6969.8 7007.9 8468.4 9796.5 9816.0 9826.6 10031.4 8169.1 8462.8 8692.7 8958.0 9039.5 8621.9 8696.6 8700.6 8958.2 9048.4 8872.7 8888.5 9419.6 9554.0 9875.8 7017.3 7037.7 7058.6 7168.3 7169.2 8772.3 8847.9 9046.1 9076.2 9248.0 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#3] mootools.html Cycles:180 Average:4904.28 Median:6197.66 stddev:2568.40 (41.4%) stddev-sans-first:2561.64 04:08:29 INFO - PROCESS | 23397 | Values: 1341.7 1348.1 1452.3 1688.7 1707.1 5865.7 6906.0 7016.2 7160.9 7223.9 6769.5 6831.3 6847.9 6852.8 6867.7 2039.8 2056.2 2065.4 2071.3 2073.8 2026.3 2034.1 2037.9 2113.2 2115.1 2039.6 2059.6 2063.2 2077.1 2082.4 2055.0 2055.6 2062.8 2067.8 2070.4 2011.5 2030.3 2091.3 2095.1 2096.8 6987.7 7057.2 7058.4 7065.3 7087.7 4233.0 4366.6 4369.9 4370.9 4393.4 2563.1 2634.7 2679.6 2702.9 2702.9 794.8 821.0 821.5 824.3 1507.3 9371.2 9384.4 9462.3 9483.9 9503.6 3689.4 3788.1 3835.0 3840.9 3869.7 7570.1 7579.8 7605.5 7611.3 7625.0 4218.3 4232.9 4241.4 4241.8 4260.9 3140.1 3696.7 3757.5 3850.1 3857.2 3105.3 3160.4 3196.2 3196.6 3220.7 934.4 964.8 965.8 967.4 979.5 854.3 862.3 864.2 869.2 1092.5 6646.4 6702.6 6720.8 6773.5 6788.3 426.5 428.2 430.6 431.5 449.1 5290.8 5366.2 5375.2 5380.4 5404.9 8102.7 8324.8 8332.0 8448.5 8718.0 8242.8 8312.4 8318.7 8327.1 8365.5 6542.8 6592.7 6624.6 6660.3 6759.2 6544.5 6609.2 6631.3 6673.4 6692.6 7543.1 7628.5 7815.1 7915.7 7948.0 7679.8 7995.4 8037.1 8049.5 8057.8 5513.8 6450.1 6763.0 6897.8 6915.3 6747.2 6761.0 6778.6 6792.3 6812.6 5803.9 6093.1 6094.6 6184.6 6217.6 5921.9 6106.1 6166.4 6210.7 6211.6 6501.4 6519.0 6524.3 6550.4 6565.9 5985.4 5990.9 6021.3 6034.0 6041.4 5902.2 5968.2 6013.6 6066.0 6072.0 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#4] prototype.html Cycles:180 Average:4907.27 Median:5685.27 stddev:1491.22 (26.2%) stddev-sans-first:1454.54 04:08:29 INFO - PROCESS | 23397 | Values: 287.8 298.2 300.9 306.1 306.2 5621.3 5712.7 5731.0 5740.8 5829.9 5627.6 5632.9 5639.3 5647.3 5657.8 4052.8 4187.5 4259.7 4278.3 4284.4 4239.2 4255.9 4272.5 4307.0 4319.6 4254.3 4258.1 4266.1 4267.8 4300.1 4267.7 4272.7 4276.3 4281.5 4287.6 3757.9 3757.9 3765.0 3771.5 3787.6 5420.9 5421.0 5424.5 5429.3 5434.5 4698.7 4840.5 4865.9 4925.2 4935.5 5911.3 5929.7 5939.1 5955.1 5972.1 3956.2 3973.1 3973.5 3982.6 4000.5 6184.0 6286.2 6286.2 6287.7 6289.7 4063.1 4098.4 4101.4 4101.9 4104.0 4149.3 4163.3 4163.9 4166.4 4168.8 4675.3 4798.3 4866.7 4871.2 4888.4 5945.6 5966.2 5976.2 5984.8 5985.9 1453.4 1457.9 1466.3 1473.8 1475.1 940.7 954.4 967.6 979.7 980.2 5138.9 5155.4 5160.8 5162.1 5165.5 6164.0 6172.5 6176.4 6188.6 6189.7 5053.3 5146.3 5147.2 5208.8 5237.3 3352.5 3353.6 3377.8 3381.0 3391.7 5857.2 5869.0 5881.9 5881.9 5886.8 6417.2 6425.7 6442.2 6444.1 6445.5 5818.2 5825.0 5836.6 5851.2 5855.3 6095.2 6239.4 6281.7 6292.6 6295.8 6074.2 6075.5 6087.6 6115.2 6124.9 5805.9 5831.1 5850.4 5854.2 5864.8 3996.4 4043.5 4054.7 4069.4 4071.9 6243.9 6255.1 6261.7 6268.9 6299.5 5768.0 5868.8 5999.4 6035.5 6041.8 5953.7 6010.2 6019.2 6023.7 6032.5 5890.7 5892.9 5898.9 5907.3 5909.1 6003.5 6033.9 6043.4 6054.6 6057.3 5759.8 5832.7 5884.0 5889.8 5902.8 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | [#5] yui.html Cycles:180 Average:11885.26 Median:604.23 stddev:14297.76 (2366.3%) stddev-sans-first:14312.56 04:08:29 INFO - PROCESS | 23397 | Values: 556.5 633.9 660.6 698.7 719.8 10751.6 10953.4 11038.4 11041.9 11054.5 11135.4 12337.6 12698.8 12707.4 12782.9 604.6 760.3 770.7 773.3 775.0 680.5 701.7 727.0 761.0 781.1 817.6 818.0 819.1 819.3 821.4 810.0 810.6 813.1 814.0 816.4 600.1 604.0 604.4 606.2 608.9 10330.6 10426.4 10488.5 10489.8 10552.5 10731.5 10803.8 10959.5 11076.7 11089.0 9336.1 9511.0 9584.6 9596.2 9617.8 3068.8 3128.1 3168.3 3177.8 3179.1 43192.6 43439.0 43996.3 44047.6 44143.3 7990.9 8063.8 8122.4 9234.4 9371.4 14931.3 14937.9 15019.0 15030.7 15163.6 6063.9 6126.4 6177.5 6245.8 6326.6 3580.1 3600.5 3655.0 3673.2 3696.7 2519.6 2526.8 2543.7 2544.2 2548.7 473.5 476.9 478.3 480.0 485.1 558.4 569.8 576.7 590.0 590.2 7168.7 7187.6 7218.2 7276.7 7447.6 461.5 474.7 561.6 614.5 624.3 3362.7 3371.6 3424.2 3459.6 3523.4 49442.0 49931.0 50224.0 50932.5 50945.0 43737.8 43912.3 44167.0 44594.3 44616.9 41113.6 41921.6 42318.2 42792.8 42836.9 6821.5 7040.4 7043.3 7056.5 7068.1 32033.7 32324.4 32424.0 32642.2 32682.0 38764.2 40374.4 40435.0 40600.4 40632.8 8124.1 8359.0 8543.9 8607.0 8708.2 8385.4 8552.4 8584.3 8720.7 8923.2 9062.4 9264.0 9320.1 9325.9 9519.2 7901.2 8027.2 8040.2 8074.0 8340.7 8282.8 8388.7 8492.9 8830.2 8851.9 7085.0 7247.0 7326.7 7607.4 7797.5 7016.6 7471.8 7484.7 7497.5 7579.9 04:08:29 INFO - PROCESS | 23397 | -------- Summary: end -------- 04:08:29 INFO - PROCESS | 23397 | 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - PROCESS | 23397 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:29 INFO - TEST-INFO | 23397: exit 0 04:08:29 INFO - TEST-OK | dromaeo_css | took 1112730ms 04:08:29 INFO - TEST-START | kraken 04:08:29 INFO - operating with platform_type : linux_ 04:08:29 INFO - Initialising browser for kraken test... 04:08:29 INFO - TEST-INFO | started process 23633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PtSHy/profile http://localhost:56688/getInfo.html) 04:08:33 INFO - PROCESS | 23633 | 04:08:33 INFO - PROCESS | 23633 | (process:23702): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:08:34 INFO - PROCESS | 23633 | __metrics Screen width/height:1600/1200 04:08:34 INFO - PROCESS | 23633 | colorDepth:24 04:08:34 INFO - PROCESS | 23633 | Browser inner width/height: 1024/697 04:08:34 INFO - PROCESS | 23633 | __metrics 04:08:34 ERROR - PROCESS | 23633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:34 INFO - PROCESS | 23633 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:08:35 INFO - TEST-INFO | 23633: exit 0 04:08:35 INFO - Browser initialized. 04:08:35 INFO - Running cycle 1/1 for kraken test... 04:08:35 INFO - TEST-INFO | started process 23753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0PtSHy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:37 INFO - PROCESS | 23753 | 04:08:37 INFO - PROCESS | 23753 | (process:23812): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:08:47 INFO - PROCESS | 23753 | RSS: Main: 161681408 04:08:47 INFO - PROCESS | 23753 | 04:08:50 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56688/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:50 INFO - PROCESS | 23753 | RSS: Main: 168296448 04:08:50 INFO - PROCESS | 23753 | 04:08:53 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56688/tests/kraken/driver.html?testName=audio-dft) 04:08:54 INFO - PROCESS | 23753 | RSS: Main: 170950656 04:08:54 INFO - PROCESS | 23753 | 04:08:57 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56688/tests/kraken/driver.html?testName=audio-fft) 04:08:57 INFO - PROCESS | 23753 | RSS: Main: 165515264 04:08:57 INFO - PROCESS | 23753 | 04:08:59 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56688/tests/kraken/driver.html?testName=audio-oscillator) 04:09:00 INFO - PROCESS | 23753 | RSS: Main: 164311040 04:09:00 INFO - PROCESS | 23753 | 04:09:02 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56688/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:09:03 INFO - PROCESS | 23753 | RSS: Main: 166330368 04:09:03 INFO - PROCESS | 23753 | 04:09:06 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56688/tests/kraken/driver.html?testName=imaging-darkroom) 04:09:07 INFO - PROCESS | 23753 | RSS: Main: 165089280 04:09:07 INFO - PROCESS | 23753 | 04:09:10 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56688/tests/kraken/driver.html?testName=imaging-desaturate) 04:09:11 INFO - PROCESS | 23753 | RSS: Main: 162619392 04:09:11 INFO - PROCESS | 23753 | 04:09:14 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56688/tests/kraken/driver.html?testName=json-parse-financial) 04:09:14 INFO - PROCESS | 23753 | RSS: Main: 163098624 04:09:14 INFO - PROCESS | 23753 | 04:09:16 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56688/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:16 INFO - PROCESS | 23753 | RSS: Main: 164425728 04:09:16 INFO - PROCESS | 23753 | 04:09:18 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:19 INFO - PROCESS | 23753 | RSS: Main: 163131392 04:09:19 INFO - PROCESS | 23753 | 04:09:21 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:22 INFO - PROCESS | 23753 | RSS: Main: 163553280 04:09:22 INFO - PROCESS | 23753 | 04:09:24 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:25 INFO - PROCESS | 23753 | RSS: Main: 163758080 04:09:25 INFO - PROCESS | 23753 | 04:09:28 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:28 INFO - PROCESS | 23753 | RSS: Main: 163913728 04:09:28 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | Cycle 1(1): loaded http://localhost:56688/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56688/tests/kraken/driver.html?testName=ai-astar) 04:09:30 INFO - PROCESS | 23753 | RSS: Main: 165933056 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | __start_tp_report 04:09:30 INFO - PROCESS | 23753 | _x_x_mozilla_page_load 04:09:30 INFO - PROCESS | 23753 | _x_x_mozilla_page_load_details 04:09:30 INFO - PROCESS | 23753 | |i|pagename|runs| 04:09:30 INFO - PROCESS | 23753 | |0;ai-astar;115;110;115;114;114;125;117;115;115;116 04:09:30 INFO - PROCESS | 23753 | |1;audio-beat-detection;157;135;159;184;135;161;154;133;182;138 04:09:30 INFO - PROCESS | 23753 | |2;audio-dft;163;163;164;164;162;164;169;163;166;165 04:09:30 INFO - PROCESS | 23753 | |3;audio-fft;74;74;77;148;75;74;74;75;162;75 04:09:30 INFO - PROCESS | 23753 | |4;audio-oscillator;98;99;149;97;98;98;140;98;98;140 04:09:30 INFO - PROCESS | 23753 | |5;imaging-gaussian-blur;121;116;116;116;117;116;116;115;115;115 04:09:30 INFO - PROCESS | 23753 | |6;imaging-darkroom;147;148;148;148;148;148;149;147;149;147 04:09:30 INFO - PROCESS | 23753 | |7;imaging-desaturate;96;96;97;96;96;97;97;96;97;97 04:09:30 INFO - PROCESS | 23753 | |8;json-parse-financial;67;68;68;70;68;71;68;75;67;66 04:09:30 INFO - PROCESS | 23753 | |9;json-stringify-tinderbox;72;72;71;71;73;71;73;72;72;74 04:09:30 INFO - PROCESS | 23753 | |10;stanford-crypto-aes;92;86;86;84;84;84;84;84;86;93 04:09:30 INFO - PROCESS | 23753 | |11;stanford-crypto-ccm;124;122;121;131;126;131;126;122;121;128 04:09:30 INFO - PROCESS | 23753 | |12;stanford-crypto-pbkdf2;139;152;153;158;153;140;163;150;162;151 04:09:30 INFO - PROCESS | 23753 | |13;stanford-crypto-sha256-iterative;70;69;70;78;70;72;70;72;70;73 04:09:30 INFO - PROCESS | 23753 | __end_tp_report 04:09:30 INFO - PROCESS | 23753 | __start_cc_report 04:09:30 INFO - PROCESS | 23753 | _x_x_mozilla_cycle_collect,838 04:09:30 INFO - PROCESS | 23753 | __end_cc_report 04:09:30 INFO - PROCESS | 23753 | __startTimestamp1456834170826__endTimestamp 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | ------- Summary: start ------- 04:09:30 INFO - PROCESS | 23753 | Number of tests: 14 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:3.78 (3.3%) stddev-sans-first:4.00 04:09:30 INFO - PROCESS | 23753 | Values: 115.0 110.0 115.0 114.0 114.0 125.0 117.0 115.0 115.0 116.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:158.00 stddev:18.81 (11.9%) stddev-sans-first:19.92 04:09:30 INFO - PROCESS | 23753 | Values: 157.0 135.0 159.0 184.0 135.0 161.0 154.0 133.0 182.0 138.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.07 04:09:30 INFO - PROCESS | 23753 | Values: 163.0 163.0 164.0 164.0 162.0 164.0 169.0 163.0 166.0 165.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#3] audio-fft Cycles:10 Average:90.80 Median:74.50 stddev:34.01 (45.6%) stddev-sans-first:35.52 04:09:30 INFO - PROCESS | 23753 | Values: 74.0 74.0 77.0 148.0 75.0 74.0 74.0 75.0 162.0 75.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:98.00 stddev:21.88 (22.3%) stddev-sans-first:22.66 04:09:30 INFO - PROCESS | 23753 | Values: 98.0 99.0 149.0 97.0 98.0 98.0 140.0 98.0 98.0 140.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:1.77 (1.5%) stddev-sans-first:0.67 04:09:30 INFO - PROCESS | 23753 | Values: 121.0 116.0 116.0 116.0 117.0 116.0 116.0 115.0 115.0 115.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:09:30 INFO - PROCESS | 23753 | Values: 147.0 148.0 148.0 148.0 148.0 148.0 149.0 147.0 149.0 147.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:09:30 INFO - PROCESS | 23753 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 97.0 96.0 97.0 97.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:68.00 stddev:2.62 (3.8%) stddev-sans-first:2.69 04:09:30 INFO - PROCESS | 23753 | Values: 67.0 68.0 68.0 70.0 68.0 71.0 68.0 75.0 67.0 66.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 04:09:30 INFO - PROCESS | 23753 | Values: 72.0 72.0 71.0 71.0 73.0 71.0 73.0 72.0 72.0 74.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:3.40 (4.0%) stddev-sans-first:2.92 04:09:30 INFO - PROCESS | 23753 | Values: 92.0 86.0 86.0 84.0 84.0 84.0 84.0 84.0 86.0 93.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.00 stddev:3.85 (3.1%) stddev-sans-first:4.06 04:09:30 INFO - PROCESS | 23753 | Values: 124.0 122.0 121.0 131.0 126.0 131.0 126.0 122.0 121.0 128.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.00 stddev:8.01 (5.2%) stddev-sans-first:6.95 04:09:30 INFO - PROCESS | 23753 | Values: 139.0 152.0 153.0 158.0 153.0 140.0 163.0 150.0 162.0 151.0 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:2.63 (3.7%) stddev-sans-first:2.74 04:09:30 INFO - PROCESS | 23753 | Values: 70.0 69.0 70.0 78.0 70.0 72.0 70.0 72.0 70.0 73.0 04:09:30 INFO - PROCESS | 23753 | -------- Summary: end -------- 04:09:30 INFO - PROCESS | 23753 | 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:30 INFO - PROCESS | 23753 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:09:31 INFO - TEST-INFO | 23753: exit 0 04:09:31 INFO - TEST-OK | kraken | took 61897ms 04:09:31 INFO - SUITE-END | took 1174s 04:09:31 INFO - Completed test suite (00:19:34) 04:09:31 INFO - Working with test: dromaeo_css 04:09:31 INFO - Generating results file: dromaeo_css 04:09:31 INFO - Working with test: kraken 04:09:31 INFO - Generating results file: kraken 04:09:31 INFO - javascript benchmark 04:09:31 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:09:32 INFO - process_Request line: dromaeo_css 6085.18 graph.html#tests=[[72,132,43]] 04:09:32 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:32 INFO - process_Request line: kraken 1572.60 graph.html#tests=[[232,132,43]] 04:09:32 INFO - RETURN: dromaeo_css: 6085.18 04:09:32 INFO - RETURN: kraken: 1572.60 04:09:32 INFO - javascript benchmark 04:09:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.331305517093, 2660.321617987413, 2690.5695088785797, 2697.473992571448, 2710.7424794644503, 4491.595756381925, 4635.258358662611, 4658.394408726861, 4690.413698287714, 4728.55078767517, 4536.546345365462, 4617.353570500132, 4686.133065382906, 4697.295405689139, 4775.665703400763, 4253.25568025595, 4316.633086187662, 4330.783460826962, 4332.0, 4332.06860524987, 95.95051718846436, 4258.212230737324, 4308.849190278341, 4331.177076355498, 4353.0, 4307.375430562583, 4313.331433627793, 4315.029118448356, 4342.739435633872, 4349.739015659071, 4166.166766646653, 4290.570942905716, 4311.698181127323, 4330.372096046087, 4378.846740364072, 4183.330667093281, 4238.978805105986, 4244.8514301999285, 4258.8509402171085, 4276.978615106936, 4542.182407166709, 4555.293929440942, 4560.612347950395, 4598.747068911209, 4615.653825963032, 4783.1868582341085, 4947.703137811743, 4948.356713627241, 4953.950460495421, 4977.029479251547, 4939.481354457802, 4942.728149951788, 4962.6774259673, 4980.501949805027, 4994.87512812179, 4609.469910960249, 4610.561996610317, 4612.331211974312, 4639.86080417588, 4655.3947986761505, 4912.631552633567, 5054.620903432257, 5057.8229761958155, 5113.642045056885, 5187.740612969336, 4867.3915760529935, 4890.682105663121, 4931.7040977541465, 4939.975300123477, 4958.429780575208, 5015.874603134878, 5024.371953505812, 5028.823991160292, 5033.3205017322925, 5033.723145226974, 4769.9046019080115, 4901.901961960741, 4984.053029924303, 5004.449510553836, 5023.321851549994, 4707.082118986833, 4879.2925025871045, 4953.2570114483115, 4967.528084831935, 5009.849704508871, 4138.627523522898, 4185.748855068706, 4188.099558594917, 4217.746935183899, 4227.852025179104, 3561.5370001899587, 3580.3913334733156, 3640.7269454790467, 3671.4492826076303, 3671.7980511071614, 4315.093830295673, 4318.654507639381, 4323.3947247385395, 4324.740515569076, 4326.459192600925, 4934.703917764946, 4940.777665005084, 4972.57733092684, 4995.475475075137, 5020.046191223656, 4216.620504154641, 4261.914761704748, 4326.069894972596, 4346.326319420495, 4367.344898265222, 4341.0666706657585, 4389.934150987738, 4394.890127746832, 4413.073254616566, 4423.358613001097, 4655.813767449332, 4661.324108004321, 4662.790174442091, 4683.367745354333, 4700.600448961876, 4969.503049695001, 5001.1498045331655, 5010.148274793221, 5022.698638081727, 5062.873428164326, 4717.952820471889, 4720.551547602972, 4720.834770783006, 4722.386089808303, 4733.479317275166, 4729.834455794031, 4912.95087049125, 4933.457319694902, 4972.428170760409, 4994.850154495371, 4949.975250123726, 4965.97517012427, 4972.179590367694, 4990.80036798524, 5030.245463180406, 4847.248676455155, 4851.927221091616, 4855.1988921828915, 4860.538248866352, 4861.149298872754, 4653.488116307136, 4805.5915247204375, 4886.071646387317, 4895.485973972682, 4899.240617704261, 4586.931196031996, 4649.604783593432, 4670.813167473263, 4684.297355396718, 4712.010477799563, 4850.854474365775, 4863.683860549053, 4932.654714169974, 4934.383202099738, 4984.302197692398, 4622.86131416058, 4811.7834697438, 4820.1805693031565, 4820.975895120502, 4827.396575428072], "unit": "score", "name": "dojo.html", "value": 4533.23720729661}, {"lowerIsBetter": false, "replicates": [483.7097741355187, 500.40701768404443, 506.1648280337443, 529.8993191293652, 531.8484231993882, 32153.19617009573, 33118.83440582794, 33274.500882486755, 33341.16647083821, 33382.49926251108, 37280.06799830006, 37547.4367884482, 37549.24901501968, 37629.0, 37706.0, 7660.195679453646, 7773.766786996399, 7778.533288002738, 7784.987951566289, 7845.37237021037, 7710.653020614058, 7776.339011184028, 7796.064472263336, 7799.415043871732, 7802.8439431211345, 7919.8416031679335, 7964.2433968772875, 7976.162502937195, 7978.0, 8014.919850801476, 7954.681812727484, 7964.084130325, 7980.800479987989, 7983.840323193533, 8010.158933312035, 7497.2877576630135, 7569.886451703229, 7573.659185336673, 7609.619519024082, 7624.27569380908, 36917.261654767026, 37457.25085498302, 37470.812645936865, 37516.24967500662, 37531.06172345713, 2194.8024677779076, 2805.5931889875856, 2915.9271018224504, 3086.9536956945662, 3189.728873045794, 24352.147674831474, 24382.634260486106, 24577.87711061451, 24821.1312604058, 24853.25440236796, 2863.21261653045, 2897.739203471677, 2911.4613796447725, 2921.8977335793147, 2951.5425109108123, 143649.0, 143875.28062359727, 144093.0, 144893.0, 144967.27516362455, 50242.497575024514, 50351.74824125856, 50440.0, 50654.49345506498, 50824.74587627038, 53121.0, 53307.46692533103, 58510.0, 60059.0, 60195.0, 12190.2076365036, 12225.083118766128, 12380.195287306477, 12397.566085186974, 12420.0, 8366.665333386718, 8389.790255243546, 8524.659013639384, 8542.487450752975, 8580.099089595627, 18014.279428822963, 18250.634987300444, 18283.0, 18363.0, 18597.907010465133, 7248.818779530448, 7827.6477558510005, 7881.645325960346, 7950.3242224410415, 8076.919230807616, 894.4186278918755, 924.5562130177552, 934.6962237272913, 948.8529277961927, 1068.893110688925, 25540.616890746653, 26171.211865500667, 26183.73816261813, 26502.0, 26610.06864759724, 951.9571619277149, 989.2975987049275, 1014.7767491151935, 1025.436010194405, 1101.9173561982884, 13558.050936434354, 13568.457261709422, 13884.930575347058, 13900.165990040428, 13980.51068212628, 253501.0, 253947.0, 254252.0, 255666.0, 257184.0, 45345.31982020273, 45944.54055459469, 46120.0, 46241.30638040432, 46325.0, 1177.328922514176, 1204.8192771084232, 1209.5929101088946, 1209.776191404593, 1218.3360068762368, 24829.0, 25408.745912541377, 25638.487230255665, 25793.226203213933, 26300.342491437867, 40254.79872600736, 40266.1946761069, 40387.79806101068, 40590.79704601458, 40715.38926916158, 240742.0, 241801.0, 243467.0, 244218.0, 244582.0, 28979.710202897702, 29539.704602953694, 29712.70287297186, 30121.09636710902, 30147.547786782776, 38442.80778596089, 38587.807060964515, 38757.41863872101, 39081.218375632896, 39476.80261598789, 32214.67785322117, 32508.674913250565, 33050.0, 33180.0, 33446.832765836014, 32936.0, 33487.66512334943, 33633.495497568045, 33708.988730338126, 33747.325053499284, 26711.0, 32316.83841580777, 32643.18392040123, 33408.498872516444, 34303.313933721685, 27933.301667457665, 28992.565111523767, 29197.562036569045, 29221.269468263465, 29500.704992949795, 22676.0, 22724.20465283707, 22876.0, 22947.77052229523, 22994.770052299933], "unit": "score", "name": "ext.html", "value": 16118.417646581782}, {"lowerIsBetter": false, "replicates": [323.83808095952025, 333.889816360601, 338.949157626356, 339.8487672985522, 341.0, 14700.632484187901, 15131.697366052673, 15686.843131568681, 15697.372105115795, 15709.921450392761, 14302.35639396227, 14543.3455494503, 14822.703545929102, 14951.626209344771, 14954.476593319236, 5034.572061374787, 5133.0, 5191.117510023286, 5191.351081114861, 5215.295935048758, 5053.292539044537, 5060.9493905060845, 5095.388553373582, 5100.183970564711, 5105.84682459525, 4936.284238785374, 5014.272930425086, 5015.172496538067, 5088.7964481420695, 5102.948970510303, 4921.507849215086, 5042.84871453857, 5056.873578160557, 5086.97456512717, 5138.409082955471, 4879.341288926021, 4913.975430122862, 4940.925886111711, 4959.776810043557, 4968.652194346397, 11155.888441115567, 11172.385518796464, 11379.203455758101, 11776.41117944108, 11823.231489953125, 1812.673718730628, 1818.9181486833124, 1941.0682872221412, 2175.4996350839237, 2178.9323231616554, 10359.948200259027, 12100.576479823163, 12617.495300187982, 12647.177933434297, 12927.353632318347, 1694.4577735124642, 1714.4085290574733, 1785.366195000769, 1791.5073354827396, 1834.5146117742127, 38406.80796596027, 48221.75889120532, 51656.0, 53575.464245357434, 55440.44559554433, 9458.196053335407, 9470.90529094714, 9508.714738557715, 9547.761305967406, 9607.615695372107, 12236.81644775329, 12304.569340073054, 12322.753544929052, 12386.0, 12388.62834114978, 6332.176817013758, 6338.904916426257, 6586.835329116715, 6679.3320667933785, 6700.095487109178, 6204.844878877974, 6212.9378706213265, 6237.625742455376, 6305.243370795442, 6305.779297724557, 4086.6730661547003, 4121.340585506305, 4145.067359844072, 4236.152769446123, 4256.8297268109545, 1693.7798086248708, 1756.4116021133063, 1761.7005109131478, 1779.5817982774038, 1779.9288028478975, 891.2914233184633, 894.7271082319825, 920.2867777472512, 923.8290916180393, 991.6380521109887, 15118.470853520073, 15449.0, 15527.378904843905, 15714.9214253928, 16013.119278439797, 862.6032025268321, 890.3678388344348, 912.5847739278612, 932.3659911260409, 932.5057719408725, 8820.0, 8903.33225008127, 8904.643814247487, 8953.462792232487, 9056.773580660536, 256914.0, 261343.0, 263770.0, 347080.0, 357290.0, 58014.419855801745, 59488.70255648694, 59700.402995970355, 64618.67690661517, 69398.65300673465, 930.7393929699559, 958.8417911044878, 963.6964356227905, 973.6154219083422, 975.7560609847538, 14227.50203742864, 14369.425222991382, 14456.566303010926, 14619.0, 14767.335469903664, 21216.363509094135, 29740.405191895607, 30958.38083238368, 32170.0, 32226.0, 41039.0, 44748.32877506775, 44930.32604511001, 45074.098518030114, 45119.548804511534, 6726.730930762715, 6894.551854129466, 6924.480663950123, 6969.756058537927, 7007.894881576883, 8468.407211495383, 9796.51017449139, 9815.950920245354, 9826.55780489894, 10031.448270345201, 8169.104725130378, 8462.788430289293, 8692.652293908173, 8957.955210223907, 9039.548022598976, 8621.8706719398, 8696.56517174126, 8700.56497175126, 8958.238549723346, 9048.41185322952, 8872.689455869013, 8888.51113188755, 9419.587061940763, 9554.04459554039, 9875.753106172404, 7017.333353331425, 7037.683304251424, 7058.576485410892, 7168.283171682999, 7169.211386747349, 8772.342074344322, 8847.911520884709, 9046.140616641409, 9076.228520575825, 9248.0], "unit": "score", "name": "jquery.html", "value": 7447.101932396684}, {"lowerIsBetter": false, "replicates": [1341.7316536692663, 1348.0563605476166, 1452.2956366162416, 1688.696034713751, 1707.1123016031656, 5865.677387743673, 6906.033155358254, 7016.228214896364, 7160.856782864346, 7223.855522889546, 6769.4584433245345, 6831.316868313166, 6847.9385695217325, 6852.7944161675105, 6867.725290988355, 2039.8470114741417, 2056.1878058167017, 2065.401033700225, 2071.2543484345624, 2073.792620737929, 2026.3009261804655, 2034.1354924157247, 2037.9490512737227, 2113.228671534894, 2115.122224276931, 2039.6022775558772, 2059.618970490464, 2063.174730107954, 2077.096463038583, 2082.4377418097106, 2054.989725051365, 2055.599158164159, 2062.845286603511, 2067.8138967492923, 2070.4099331690545, 2011.4770159758423, 2030.3198428526314, 2091.278508914422, 2095.0991073838245, 2096.7693553709078, 6987.685554150075, 7057.153141623038, 7058.400035996947, 7065.293470652894, 7087.681054352515, 4232.957670423287, 4366.607005369532, 4369.868903932887, 4370.890727731832, 4393.406890069831, 2563.064481464252, 2634.7233540478164, 2679.6114563388396, 2702.90539831105, 2702.9053983110693, 794.7575989323254, 820.9753707388788, 821.4988856797349, 824.3034635732796, 1507.3443052272296, 9371.156595906334, 9384.390014649027, 9462.290328225341, 9483.90516094837, 9503.57233924475, 3689.446583012516, 3788.1476667749534, 3835.0, 3840.9423858642144, 3869.6517313441927, 7570.091589009354, 7579.772606821804, 7605.543667379864, 7611.314981651678, 7624.961875190588, 4218.325067989107, 4232.91534169321, 4241.427407299975, 4241.830326786956, 4260.893477663083, 3140.0736782649174, 3696.74122811406, 3757.5490941087246, 3850.133719913053, 3857.2478366718783, 3105.2547388627017, 3160.3995240904155, 3196.2329041030453, 3196.5524826524306, 3220.6940340667597, 934.4393363981557, 964.8070385922844, 965.830979578585, 967.3615413826841, 979.4612962870535, 854.2994744309731, 862.3316929379781, 864.1962974433711, 869.1569177897429, 1092.5083712329324, 6646.401823835781, 6702.631355275409, 6720.764773232913, 6773.491988100814, 6788.287229840895, 426.5244252658264, 428.15653163268314, 430.58663682864176, 431.4714474768446, 449.05025870284766, 5290.81482148123, 5366.168243922199, 5375.220593013991, 5380.381256155514, 5404.945950540444, 8102.716404925917, 8324.791880203044, 8331.95834020826, 8448.450850694686, 8718.0, 8242.752717418487, 8312.41813073079, 8318.70884519039, 8327.084020757833, 8365.539895305696, 6542.8364290893105, 6592.736290548421, 6624.6025238485845, 6660.267370589231, 6759.2226893906845, 6544.5418820684, 6609.239937407067, 6631.33686631333, 6673.432758215606, 6692.59844409337, 7543.0948286206, 7628.46600737943, 7815.062192536705, 7915.683372665029, 7948.046234451672, 7679.769606911802, 7995.360371170176, 8037.115917249215, 8049.476784009021, 8057.798555036171, 5513.779448822002, 6450.129232553733, 6763.0, 6897.793066208022, 6915.343042410963, 6747.190337159376, 6761.0, 6778.593284402951, 6792.286809884891, 6812.557183783237, 5803.912941305968, 6093.146959425595, 6094.603850749687, 6184.5980011299125, 6217.626942383471, 5921.85195370102, 6106.053561697944, 6166.414190651881, 6210.72051757681, 6211.596246243979, 6501.44737697301, 6519.0, 6524.314946930694, 6550.410463058348, 6565.901511477427, 5985.371535988833, 5990.88018239624, 6021.307549631849, 6034.0, 6041.426064523863, 5902.2327097477055, 5968.194293770285, 6013.579049466495, 6065.968785306421, 6072.0], "unit": "score", "name": "mootools.html", "value": 3941.4079105602536}, {"lowerIsBetter": false, "replicates": [287.79278919178194, 298.2082570774594, 300.88415959855456, 306.1214314916191, 306.15195907336664, 5621.325440947087, 5712.714364281785, 5731.025725626649, 5740.7703691852275, 5829.912551311723, 5627.6060675752715, 5632.943670563293, 5639.2668953036045, 5647.265855438787, 5657.830265092043, 4052.797360131989, 4187.497500299968, 4259.659227261827, 4278.2940814765525, 4284.4001839742305, 4239.173361194568, 4255.936160957588, 4272.487301523822, 4307.0, 4319.632831209336, 4254.255505286578, 4258.063226090255, 4266.104118135196, 4267.8079486423185, 4300.096979634281, 4267.658587313023, 4272.743635381856, 4276.33716773899, 4281.507626622947, 4287.635550978171, 3757.8684746034032, 3757.887263382103, 3765.039914821703, 3771.5097037384962, 3787.6401741834484, 5420.91868621971, 5421.024215641183, 5424.511793938565, 5429.348478182604, 5434.483724046209, 4698.694584851974, 4840.5159484051665, 4865.854024379274, 4925.236588328815, 4935.457099719028, 5911.29064512257, 5929.673867937262, 5939.07944268639, 5955.076963070731, 5972.104184372379, 3956.208758248333, 3973.1060511384994, 3973.4834471518807, 3982.6415622594104, 4000.4999375078114, 6183.969080154616, 6286.151369565096, 6286.245650521921, 6287.6856157192415, 6289.748410063592, 4063.065494936122, 4098.364753463218, 4101.364288535222, 4101.91796164075, 4104.0, 4149.2738770715005, 4163.333866581393, 4163.875083747493, 4166.395872598517, 4168.812403441852, 4675.275332323496, 4798.2802579613335, 4866.732329721899, 4871.244957031666, 4888.388951381077, 5945.554083443759, 5966.224390829251, 5976.193213916153, 5984.820455386345, 5985.9401405986255, 1453.3750487290567, 1457.8979471436899, 1466.340146933884, 1473.7789331600345, 1475.063334782421, 940.6895724410928, 954.4082668745423, 967.56943160293, 979.6962941488162, 980.2158273381267, 5138.871528211825, 5155.38135423744, 5160.7935682573025, 5162.070827251131, 5165.483451654804, 6163.96918015407, 6172.537059720539, 6176.4441200292185, 6188.628682279078, 6189.659568723673, 5053.31780209667, 5146.305248791366, 5147.202183661539, 5208.828013696888, 5237.3453318335205, 3352.5138854866395, 3353.597568291772, 3377.847996840148, 3381.036404624719, 3391.7117045051446, 5857.20927674767, 5869.031609784423, 5881.853038657507, 5881.882362352729, 5886.793962211302, 6417.1657684500715, 6425.710843011982, 6442.194725659293, 6444.065610486547, 6445.45213656835, 5818.21454103699, 5824.970875145597, 5836.591438599342, 5851.210086638334, 5855.301962430933, 6095.207623008981, 6239.376062393906, 6281.654509002049, 6292.590981586182, 6295.811125666238, 6074.210352654127, 6075.483583895419, 6087.634741915499, 6115.174451448997, 6124.908126378197, 5805.912911306418, 5831.125331200354, 5850.414958504116, 5854.209681692917, 5864.765409383747, 3996.3805610130476, 4043.5147782266317, 4054.6958978076173, 4069.369247766601, 4071.877843664695, 6243.875122497616, 6255.061740738925, 6261.74953001893, 6268.874622507616, 6299.527535434769, 5767.9711601443405, 5868.765249389977, 5999.400059993965, 6035.517158627387, 6041.78853740117, 5953.7023148843255, 6010.188624535806, 6019.187409699634, 6023.698815059317, 6032.517398608188, 5890.676012819336, 5892.94107058924, 5898.882022359615, 5907.32065812437, 5909.084091965752, 6003.489703375262, 6033.879322413615, 6043.395660434097, 6054.636721796706, 6057.273127224761, 5759.753696058624, 5832.708364581669, 5884.0, 5889.823305300848, 5902.822915312548], "unit": "score", "name": "prototype.html", "value": 4416.588010173042}, {"lowerIsBetter": false, "replicates": [556.5130510803048, 633.8985762278037, 660.5607271164675, 698.6576577477038, 719.8272414620493, 10751.569937202512, 10953.397563134024, 11038.448077596118, 11041.944790276048, 11054.502547385368, 11135.387553684544, 12337.629871103858, 12698.80951785724, 12707.428165732541, 12782.936085319561, 604.5828378418877, 760.3195140349384, 770.6878714120791, 773.3310686256403, 774.9767506974799, 680.5440354962187, 701.7087908517959, 727.04756768633, 760.9581473018982, 781.1173374087302, 817.6157206113147, 817.963191656374, 819.0785366462729, 819.3117781063905, 821.3552361396305, 810.0279664402682, 810.6109067647533, 813.1380736419385, 814.0069115678863, 816.3958670583785, 600.1118344849604, 604.030530997751, 604.4348534120568, 606.2088973889073, 608.922207692382, 10330.638427654996, 10426.426546539937, 10488.528016239212, 10489.842652360221, 10552.472376381227, 10731.463426828705, 10803.837942430791, 10959.452027398598, 11076.667699969013, 11089.0, 9336.11306925841, 9511.0, 9584.5686944087, 9596.184324332371, 9617.807643847154, 3068.8005279656973, 3128.139761565565, 3168.30297334586, 3177.8411079445937, 3179.0925444733207, 43192.56807431917, 43439.0, 43996.3400548992, 44047.559524404984, 44143.33784993228, 7990.880136797953, 8063.758087257392, 8122.390820688472, 9234.353595248402, 9371.437713737061, 14931.25343732809, 14937.925310373379, 15019.0, 15030.699386012218, 15163.620909477351, 6063.938810708109, 6126.356732543108, 6177.4749146322165, 6245.812625621239, 6326.557141000178, 3580.122869896892, 3600.477930700034, 3654.9634503655157, 3673.1551743099235, 3696.667299943018, 2519.6472493850874, 2526.8231223814523, 2543.707473640518, 2544.1731437282956, 2548.668673072526, 473.49572705068994, 476.8688610632104, 478.3207844860307, 480.015967267101, 485.09529727059487, 558.4192439862578, 569.7977218087602, 576.7462316580691, 589.9587028907936, 590.2238556298539, 7168.749093781797, 7187.64061796908, 7218.205997340288, 7276.745313913988, 7447.590382528904, 461.53385081068365, 474.73889360851393, 561.5619816543103, 614.5145335185243, 624.3350831364583, 3362.7309815214726, 3371.6291207967106, 3424.2124311408515, 3459.5502584664337, 3523.4010218262956, 49442.0, 49931.0, 50224.0, 50932.49067509278, 50945.0, 43737.78131109324, 43912.3413148803, 44167.0, 44594.3310850331, 44616.86906005786, 41113.588864111574, 41921.580784192374, 42318.15363692709, 42792.78603606962, 42836.85957685098, 6821.488388370992, 7040.3663670269925, 7043.330883566053, 7056.54132481387, 7068.11648543932, 32033.679663204002, 32324.353512929138, 32424.0, 32642.183945401554, 32682.019539413857, 38764.22471550497, 40374.39438408367, 40435.0, 40600.390994135705, 40632.79683601563, 8124.065732440608, 8358.958205208935, 8543.8718419225, 8606.961703654326, 8708.17272359125, 8385.413021088465, 8552.401331906707, 8584.313254939465, 8720.738377848675, 8923.15230053144, 9062.410943288665, 9264.040034951191, 9320.114589114024, 9325.906740932503, 9519.190868776232, 7901.17037711032, 8027.237412445808, 8040.195980401913, 8074.0, 8340.708075217339, 8282.792930176794, 8388.706395276136, 8492.91507084946, 8830.249428798625, 8851.867221991804, 7085.0, 7247.0, 7326.6702998364135, 7607.429442791702, 7797.454178207471, 7016.6491675415, 7471.813204669927, 7484.663190156565, 7497.482151805213, 7579.886301705589], "unit": "score", "name": "yui.html", "value": 5359.709124783861}], "name": "dromaeo_css", "value": 6085.178718642561}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 114.0, 114.0, 125.0, 117.0, 115.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 159.0, 184.0, 135.0, 161.0, 154.0, 133.0, 182.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 164.0, 162.0, 164.0, 169.0, 163.0, 166.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 77.0, 148.0, 75.0, 74.0, 74.0, 75.0, 162.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 149.0, 97.0, 98.0, 98.0, 140.0, 98.0, 98.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 70.0, 68.0, 71.0, 68.0, 75.0, 67.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 71.0, 73.0, 71.0, 73.0, 72.0, 72.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.1}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 86.0, 84.0, 84.0, 84.0, 84.0, 84.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 121.0, 131.0, 126.0, 131.0, 126.0, 122.0, 121.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 153.0, 158.0, 153.0, 140.0, 163.0, 150.0, 162.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 78.0, 70.0, 72.0, 70.0, 72.0, 70.0, 73.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1572.6}]} 04:09:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1572.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6085.18"}}} 04:09:32 INFO - Return code: 0 04:09:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:09:32 ERROR - # TBPL SUCCESS # 04:09:32 INFO - Running post-action listener: _resource_record_post_action 04:09:32 INFO - Running post-run listener: _resource_record_post_run 04:09:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 535138304; Read time: 0; Write time: 427376 04:09:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240689152; Read time: 0; Write time: 270108 04:09:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294449152; Read time: 0; Write time: 157268 04:09:33 INFO - Running post-run listener: _upload_blobber_files 04:09:33 INFO - Blob upload gear active. 04:09:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:09:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:34 INFO - (blobuploader) - INFO - Done attempting. 04:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:35 INFO - (blobuploader) - INFO - Done attempting. 04:09:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:35 INFO - Return code: 0 04:09:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:09:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3189c4ca54f78b5b5a2d1885ba7d3ef3ec461a4d3702418f37712c61813fdf8e5f5be2db267cce59709747c1d5d899d359a058553f50ac7602b79a6275949beb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/131a49666626f0d7b34de276cef6b6fe30efb73b777c104923e5fabfb4cf13a6a8a1be3269b2aad1a05681b58a991783bdfd70ff99d988a666978f020b40066f"} 04:09:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:09:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:09:35 INFO - Contents: 04:09:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3189c4ca54f78b5b5a2d1885ba7d3ef3ec461a4d3702418f37712c61813fdf8e5f5be2db267cce59709747c1d5d899d359a058553f50ac7602b79a6275949beb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/131a49666626f0d7b34de276cef6b6fe30efb73b777c104923e5fabfb4cf13a6a8a1be3269b2aad1a05681b58a991783bdfd70ff99d988a666978f020b40066f"} 04:09:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:09:35 INFO - Copying logs to upload dir... 04:09:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:09:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.642209 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-03-01 04:09:34.778809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:09:34.782764) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3189c4ca54f78b5b5a2d1885ba7d3ef3ec461a4d3702418f37712c61813fdf8e5f5be2db267cce59709747c1d5d899d359a058553f50ac7602b79a6275949beb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/131a49666626f0d7b34de276cef6b6fe30efb73b777c104923e5fabfb4cf13a6a8a1be3269b2aad1a05681b58a991783bdfd70ff99d988a666978f020b40066f"} build_url:https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/DBxcHgtzR768WnWMMXdcKw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3189c4ca54f78b5b5a2d1885ba7d3ef3ec461a4d3702418f37712c61813fdf8e5f5be2db267cce59709747c1d5d899d359a058553f50ac7602b79a6275949beb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/131a49666626f0d7b34de276cef6b6fe30efb73b777c104923e5fabfb4cf13a6a8a1be3269b2aad1a05681b58a991783bdfd70ff99d988a666978f020b40066f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:09:34.809310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:09:34.809675) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1456832813.79645-1176283319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:09:34.891652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:09:34.892015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:09:34.892376) ========= ========= Total master_lag: 0.28 =========