builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1459854755.98 results: success (0) buildid: 20160404093933 builduid: 027adc442bc2424085bbc73e0b2730b2 revision: b3501e6ad98af3c4e6833bcc2725f374f171805b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:35.983624) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:35.984121) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:35.984450) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004963 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.006194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.006559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.020755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.021062) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.071007) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.071382) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.071829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.072139) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 04:12:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-05 04:12:36 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.295778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.296090) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.345031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.345391) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3501e6ad98af3c4e6833bcc2725f374f171805b --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 b3501e6ad98af3c4e6833bcc2725f374f171805b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 04:12:36,759 truncating revision to first 12 chars 2016-04-05 04:12:36,759 Setting DEBUG logging. 2016-04-05 04:12:36,759 attempt 1/10 2016-04-05 04:12:36,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3501e6ad98a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 04:12:37,020 unpacking tar archive at: fx-team-b3501e6ad98a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.947233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.947620) ========= echo b3501e6ad98af3c4e6833bcc2725f374f171805b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b3501e6ad98af3c4e6833bcc2725f374f171805b'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b3501e6ad98af3c4e6833bcc2725f374f171805b program finished with exit code 0 elapsedTime=0.003425 script_repo_revision: 'b3501e6ad98af3c4e6833bcc2725f374f171805b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.995934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:36.996263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 04:12:37.210388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-05 04:12:37.210834) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:37 INFO - MultiFileLogger online at 20160405 04:12:37 in /builds/slave/test 04:12:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:12:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:37 INFO - {'append_to_log': False, 04:12:37 INFO - 'base_work_dir': '/builds/slave/test', 04:12:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:12:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:37 INFO - 'branch': 'Fx-Team-Non-PGO', 04:12:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:37 INFO - 'config_files': ('talos/linux_config.py',), 04:12:37 INFO - 'default_actions': ('clobber', 04:12:37 INFO - 'read-buildbot-config', 04:12:37 INFO - 'download-and-extract', 04:12:37 INFO - 'populate-webroot', 04:12:37 INFO - 'create-virtualenv', 04:12:37 INFO - 'install', 04:12:37 INFO - 'run-tests'), 04:12:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:37 INFO - 'download_minidump_stackwalk': True, 04:12:37 INFO - 'download_symbols': 'ondemand', 04:12:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:37 INFO - 'installer_path': 'installer.exe', 04:12:37 INFO - 'log_level': 'info', 04:12:37 INFO - 'log_name': 'talos', 04:12:37 INFO - 'log_to_console': True, 04:12:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:37 INFO - 'opt_config_files': (), 04:12:37 INFO - 'pip_index': False, 04:12:37 INFO - 'sps_profile': False, 04:12:37 INFO - 'sps_profile_interval': 0, 04:12:37 INFO - 'suite': 'dromaeojs', 04:12:37 INFO - 'system_bits': '32', 04:12:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:37 INFO - 'title': 'talos-linux64-ix-015', 04:12:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:37 INFO - 'use_talos_json': True, 04:12:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:37 INFO - 'work_dir': 'build'} 04:12:37 INFO - ##### 04:12:37 INFO - ##### Running clobber step. 04:12:37 INFO - ##### 04:12:37 INFO - Running pre-action listener: _resource_record_pre_action 04:12:37 INFO - Running main action method: clobber 04:12:37 INFO - rmtree: /builds/slave/test/build 04:12:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:38 INFO - Running post-action listener: _resource_record_post_action 04:12:38 INFO - ##### 04:12:38 INFO - ##### Running read-buildbot-config step. 04:12:38 INFO - ##### 04:12:38 INFO - Running pre-action listener: _resource_record_pre_action 04:12:38 INFO - Running main action method: read_buildbot_config 04:12:38 INFO - Using buildbot properties: 04:12:38 INFO - { 04:12:38 INFO - "project": "", 04:12:38 INFO - "product": "firefox", 04:12:38 INFO - "script_repo_revision": "production", 04:12:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:12:38 INFO - "repository": "", 04:12:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:12:38 INFO - "buildid": "20160404093933", 04:12:38 INFO - "pgo_build": "False", 04:12:38 INFO - "basedir": "/builds/slave/test", 04:12:38 INFO - "buildnumber": 1532, 04:12:38 INFO - "slavename": "talos-linux64-ix-015", 04:12:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:12:38 INFO - "platform": "ubuntu64_hw", 04:12:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:12:38 INFO - "branch": "fx-team", 04:12:38 INFO - "repo_path": "integration/fx-team", 04:12:38 INFO - "revision": "b3501e6ad98af3c4e6833bcc2725f374f171805b", 04:12:38 INFO - "stage_platform": "linux64", 04:12:38 INFO - "builduid": "027adc442bc2424085bbc73e0b2730b2", 04:12:38 INFO - "slavebuilddir": "test" 04:12:38 INFO - } 04:12:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:12:38 INFO - Running post-action listener: _resource_record_post_action 04:12:38 INFO - ##### 04:12:38 INFO - ##### Running download-and-extract step. 04:12:38 INFO - ##### 04:12:38 INFO - Running pre-action listener: _resource_record_pre_action 04:12:38 INFO - Running main action method: download_and_extract 04:12:38 INFO - mkdir: /builds/slave/test/build/tests 04:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:38 INFO - https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:12:38 INFO - Downloaded 1361 bytes. 04:12:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:12:38 INFO - Using the following test package requirements: 04:12:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:12:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'jsshell-linux-x86_64.zip'], 04:12:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:12:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:12:38 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:12:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:12:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:38 INFO - https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:39 INFO - Downloaded 22125225 bytes. 04:12:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:41 INFO - Return code: 0 04:12:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:41 INFO - https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:42 INFO - Downloaded 22125225 bytes. 04:12:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:43 INFO - Return code: 0 04:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:43 INFO - https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:12:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:12:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:12:44 INFO - Downloaded 10847584 bytes. 04:12:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:12:44 INFO - Return code: 0 04:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:44 INFO - https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:46 INFO - Downloaded 54086486 bytes. 04:12:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:12:46 INFO - mkdir: /builds/slave/test/properties 04:12:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:46 INFO - Contents: 04:12:46 INFO - build_url:https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:12:46 INFO - Running post-action listener: _resource_record_post_action 04:12:46 INFO - Running post-action listener: set_extra_try_arguments 04:12:46 INFO - ##### 04:12:46 INFO - ##### Running populate-webroot step. 04:12:46 INFO - ##### 04:12:46 INFO - Running pre-action listener: _resource_record_pre_action 04:12:46 INFO - Running main action method: populate_webroot 04:12:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:46 INFO - '--tppagecycles', 04:12:46 INFO - '7'], 04:12:46 INFO - 'tests': ['tsvgm']}}, 04:12:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:12:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:12:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'tests': ['damp', 'tps']}, 04:12:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['damp', 'tps']}, 04:12:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:12:46 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['dromaeo_dom']}, 04:12:46 INFO - 'other': {'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'other_l64': {'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'other_nol64': {'tests': ['a11yr', 04:12:46 INFO - 'ts_paint', 04:12:46 INFO - 'tpaint', 04:12:46 INFO - 'sessionrestore', 04:12:46 INFO - 'sessionrestore_no_auto_restore', 04:12:46 INFO - 'tabpaint']}, 04:12:46 INFO - 'svgr': {'tests': ['tsvgx', 04:12:46 INFO - 'tsvgr_opacity', 04:12:46 INFO - 'tart', 04:12:46 INFO - 'tscrollx', 04:12:46 INFO - 'cart']}, 04:12:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['tsvgx', 04:12:46 INFO - 'tsvgr_opacity', 04:12:46 INFO - 'tart', 04:12:46 INFO - 'tscrollx', 04:12:46 INFO - 'cart']}, 04:12:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'tests': ['tp5o']}, 04:12:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'talos_options': ['--e10s'], 04:12:46 INFO - 'tests': ['tp5o']}, 04:12:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'talos_options': ['--xperf_path', 04:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:46 INFO - 'tests': ['tp5n']}, 04:12:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:46 INFO - 'talos_options': ['--e10s', 04:12:46 INFO - '--xperf_path', 04:12:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:46 INFO - 'tests': ['tp5n']}}, 04:12:46 INFO - 'talos.zip': {'path': '', 04:12:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:46 INFO - Running post-action listener: _resource_record_post_action 04:12:46 INFO - ##### 04:12:46 INFO - ##### Running create-virtualenv step. 04:12:46 INFO - ##### 04:12:46 INFO - Running pre-action listener: _resource_record_pre_action 04:12:46 INFO - Running main action method: create_virtualenv 04:12:46 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:47 INFO - Using real prefix '/usr' 04:12:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:49 INFO - Installing pip.................done. 04:12:49 INFO - Return code: 0 04:12:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:49 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:49 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 04:12:49 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 04:12:49 INFO - Using env: {'DISPLAY': ':0', 04:12:49 INFO - 'HOME': '/home/cltbld', 04:12:49 INFO - 'LANG': 'en_US.UTF-8', 04:12:49 INFO - 'LANGUAGE': 'en_US:en', 04:12:49 INFO - 'LOGNAME': 'cltbld', 04:12:49 INFO - 'MAIL': '/var/mail/cltbld', 04:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:49 INFO - 'MOZ_NO_REMOTE': '1', 04:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:49 INFO - 'NO_EM_RESTART': '1', 04:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:49 INFO - 'PWD': '/builds/slave/test', 04:12:49 INFO - 'SHELL': '/bin/bash', 04:12:49 INFO - 'SHLVL': '1', 04:12:49 INFO - 'TERM': 'linux', 04:12:49 INFO - 'TMOUT': '86400', 04:12:49 INFO - 'USER': 'cltbld', 04:12:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:49 INFO - '_': '/tools/buildbot/bin/python'} 04:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:12:49 INFO - Cleaning up... 04:12:49 INFO - Return code: 0 04:12:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:49 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:49 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 04:12:49 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 04:12:49 INFO - Using env: {'DISPLAY': ':0', 04:12:49 INFO - 'HOME': '/home/cltbld', 04:12:49 INFO - 'LANG': 'en_US.UTF-8', 04:12:49 INFO - 'LANGUAGE': 'en_US:en', 04:12:49 INFO - 'LOGNAME': 'cltbld', 04:12:49 INFO - 'MAIL': '/var/mail/cltbld', 04:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:49 INFO - 'MOZ_NO_REMOTE': '1', 04:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:49 INFO - 'NO_EM_RESTART': '1', 04:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:49 INFO - 'PWD': '/builds/slave/test', 04:12:49 INFO - 'SHELL': '/bin/bash', 04:12:49 INFO - 'SHLVL': '1', 04:12:49 INFO - 'TERM': 'linux', 04:12:49 INFO - 'TMOUT': '86400', 04:12:49 INFO - 'USER': 'cltbld', 04:12:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:49 INFO - '_': '/tools/buildbot/bin/python'} 04:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:50 INFO - Downloading/unpacking psutil>=0.7.1 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:52 INFO - Installing collected packages: psutil 04:12:52 INFO - Running setup.py install for psutil 04:12:52 INFO - building 'psutil._psutil_linux' extension 04:12:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:12:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:12:52 INFO - building 'psutil._psutil_posix' extension 04:12:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:12:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:52 INFO - Successfully installed psutil 04:12:52 INFO - Cleaning up... 04:12:52 INFO - Return code: 0 04:12:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:52 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:52 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 04:12:52 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 04:12:52 INFO - Using env: {'DISPLAY': ':0', 04:12:52 INFO - 'HOME': '/home/cltbld', 04:12:52 INFO - 'LANG': 'en_US.UTF-8', 04:12:52 INFO - 'LANGUAGE': 'en_US:en', 04:12:52 INFO - 'LOGNAME': 'cltbld', 04:12:52 INFO - 'MAIL': '/var/mail/cltbld', 04:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:52 INFO - 'MOZ_NO_REMOTE': '1', 04:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:52 INFO - 'NO_EM_RESTART': '1', 04:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:52 INFO - 'PWD': '/builds/slave/test', 04:12:52 INFO - 'SHELL': '/bin/bash', 04:12:52 INFO - 'SHLVL': '1', 04:12:52 INFO - 'TERM': 'linux', 04:12:52 INFO - 'TMOUT': '86400', 04:12:52 INFO - 'USER': 'cltbld', 04:12:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:52 INFO - '_': '/tools/buildbot/bin/python'} 04:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:12:54 INFO - Installing collected packages: mozsystemmonitor 04:12:54 INFO - Running setup.py install for mozsystemmonitor 04:12:54 INFO - Successfully installed mozsystemmonitor 04:12:54 INFO - Cleaning up... 04:12:54 INFO - Return code: 0 04:12:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:54 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:54 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 04:12:54 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 04:12:54 INFO - Using env: {'DISPLAY': ':0', 04:12:54 INFO - 'HOME': '/home/cltbld', 04:12:54 INFO - 'LANG': 'en_US.UTF-8', 04:12:54 INFO - 'LANGUAGE': 'en_US:en', 04:12:54 INFO - 'LOGNAME': 'cltbld', 04:12:54 INFO - 'MAIL': '/var/mail/cltbld', 04:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:54 INFO - 'MOZ_NO_REMOTE': '1', 04:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:54 INFO - 'NO_EM_RESTART': '1', 04:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:54 INFO - 'PWD': '/builds/slave/test', 04:12:54 INFO - 'SHELL': '/bin/bash', 04:12:54 INFO - 'SHLVL': '1', 04:12:54 INFO - 'TERM': 'linux', 04:12:54 INFO - 'TMOUT': '86400', 04:12:54 INFO - 'USER': 'cltbld', 04:12:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:54 INFO - '_': '/tools/buildbot/bin/python'} 04:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:57 INFO - Downloading docopt-0.6.1.tar.gz 04:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:57 INFO - Running setup.py install for blobuploader 04:12:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:57 INFO - Running setup.py install for requests 04:12:58 INFO - Running setup.py install for docopt 04:12:58 INFO - Successfully installed blobuploader requests docopt 04:12:58 INFO - Cleaning up... 04:12:58 INFO - Return code: 0 04:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:58 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:12:58 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 04:12:58 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 04:12:58 INFO - Using env: {'DISPLAY': ':0', 04:12:58 INFO - 'HOME': '/home/cltbld', 04:12:58 INFO - 'LANG': 'en_US.UTF-8', 04:12:58 INFO - 'LANGUAGE': 'en_US:en', 04:12:58 INFO - 'LOGNAME': 'cltbld', 04:12:58 INFO - 'MAIL': '/var/mail/cltbld', 04:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:58 INFO - 'MOZ_NO_REMOTE': '1', 04:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:58 INFO - 'NO_EM_RESTART': '1', 04:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:58 INFO - 'PWD': '/builds/slave/test', 04:12:58 INFO - 'SHELL': '/bin/bash', 04:12:58 INFO - 'SHLVL': '1', 04:12:58 INFO - 'TERM': 'linux', 04:12:58 INFO - 'TMOUT': '86400', 04:12:58 INFO - 'USER': 'cltbld', 04:12:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:58 INFO - '_': '/tools/buildbot/bin/python'} 04:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:58 INFO - Running setup.py (path:/tmp/pip-yOoQC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:58 INFO - Running setup.py (path:/tmp/pip-Y4n0Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:58 INFO - Running setup.py (path:/tmp/pip-4NSSWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:58 INFO - Running setup.py (path:/tmp/pip-whXjUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:58 INFO - Running setup.py (path:/tmp/pip-lHTE43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:59 INFO - Running setup.py (path:/tmp/pip-0yI83i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:59 INFO - Running setup.py (path:/tmp/pip-acQmir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:59 INFO - Running setup.py (path:/tmp/pip-Q2FCSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:59 INFO - Running setup.py (path:/tmp/pip-9dJviT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:59 INFO - Running setup.py (path:/tmp/pip-dVD6el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:59 INFO - Running setup.py (path:/tmp/pip-x40_of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:59 INFO - Running setup.py (path:/tmp/pip-AfdGYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:59 INFO - Running setup.py (path:/tmp/pip-JGTnqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:59 INFO - Running setup.py (path:/tmp/pip-7j3AHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:59 INFO - Running setup.py (path:/tmp/pip-Mh3KGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:59 INFO - Running setup.py (path:/tmp/pip-_sAP1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:59 INFO - Running setup.py (path:/tmp/pip-vqexR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:59 INFO - Running setup.py install for manifestparser 04:12:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:59 INFO - Running setup.py install for mozcrash 04:13:00 INFO - Running setup.py install for mozdebug 04:13:00 INFO - Running setup.py install for mozdevice 04:13:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozfile 04:13:00 INFO - Running setup.py install for mozhttpd 04:13:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozinfo 04:13:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozInstall 04:13:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozleak 04:13:00 INFO - Running setup.py install for mozlog 04:13:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for moznetwork 04:13:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:00 INFO - Running setup.py install for mozprocess 04:13:01 INFO - Running setup.py install for mozprofile 04:13:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozrunner 04:13:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Running setup.py install for mozscreenshot 04:13:01 INFO - Running setup.py install for moztest 04:13:01 INFO - Running setup.py install for mozversion 04:13:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:01 INFO - Cleaning up... 04:13:01 INFO - Return code: 0 04:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:01 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 04:13:01 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 04:13:01 INFO - Using env: {'DISPLAY': ':0', 04:13:01 INFO - 'HOME': '/home/cltbld', 04:13:01 INFO - 'LANG': 'en_US.UTF-8', 04:13:01 INFO - 'LANGUAGE': 'en_US:en', 04:13:01 INFO - 'LOGNAME': 'cltbld', 04:13:01 INFO - 'MAIL': '/var/mail/cltbld', 04:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:01 INFO - 'MOZ_NO_REMOTE': '1', 04:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:01 INFO - 'NO_EM_RESTART': '1', 04:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:01 INFO - 'PWD': '/builds/slave/test', 04:13:01 INFO - 'SHELL': '/bin/bash', 04:13:01 INFO - 'SHLVL': '1', 04:13:01 INFO - 'TERM': 'linux', 04:13:01 INFO - 'TMOUT': '86400', 04:13:01 INFO - 'USER': 'cltbld', 04:13:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:01 INFO - '_': '/tools/buildbot/bin/python'} 04:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:01 INFO - Running setup.py (path:/tmp/pip-WflFav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:01 INFO - Running setup.py (path:/tmp/pip-4mHb6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:02 INFO - Running setup.py (path:/tmp/pip-fkq3ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:02 INFO - Running setup.py (path:/tmp/pip-o3wgnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:02 INFO - Running setup.py (path:/tmp/pip-GMR2Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:02 INFO - Running setup.py (path:/tmp/pip-PuFgmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:02 INFO - Running setup.py (path:/tmp/pip-bVwj18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:02 INFO - Running setup.py (path:/tmp/pip-7cLczU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:02 INFO - Running setup.py (path:/tmp/pip-1mARxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:02 INFO - Running setup.py (path:/tmp/pip-5rj5Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:02 INFO - Running setup.py (path:/tmp/pip-4Cixnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:02 INFO - Running setup.py (path:/tmp/pip-gdLsOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:02 INFO - Running setup.py (path:/tmp/pip-kU9rKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:02 INFO - Running setup.py (path:/tmp/pip-vKbX_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:02 INFO - Running setup.py (path:/tmp/pip-h0e83K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:02 INFO - Running setup.py (path:/tmp/pip-QBnfXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:13:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:03 INFO - Running setup.py (path:/tmp/pip-vRPJ5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:13:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:03 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:13:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:04 INFO - Downloading blessings-1.6.tar.gz 04:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:05 INFO - Installing collected packages: blessings 04:13:05 INFO - Running setup.py install for blessings 04:13:05 INFO - Successfully installed blessings 04:13:05 INFO - Cleaning up... 04:13:05 INFO - Return code: 0 04:13:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:05 INFO - Reading from file tmpfile_stdout 04:13:05 INFO - Current package versions: 04:13:05 INFO - argparse == 1.2.1 04:13:05 INFO - blessings == 1.6 04:13:05 INFO - blobuploader == 1.2.4 04:13:05 INFO - docopt == 0.6.1 04:13:05 INFO - manifestparser == 1.1 04:13:05 INFO - mozInstall == 1.12 04:13:05 INFO - mozcrash == 0.17 04:13:05 INFO - mozdebug == 0.1 04:13:05 INFO - mozdevice == 0.48 04:13:05 INFO - mozfile == 1.2 04:13:05 INFO - mozhttpd == 0.7 04:13:05 INFO - mozinfo == 0.9 04:13:05 INFO - mozleak == 0.1 04:13:05 INFO - mozlog == 3.1 04:13:05 INFO - moznetwork == 0.27 04:13:05 INFO - mozprocess == 0.22 04:13:05 INFO - mozprofile == 0.28 04:13:05 INFO - mozrunner == 6.11 04:13:05 INFO - mozscreenshot == 0.1 04:13:05 INFO - mozsystemmonitor == 0.0 04:13:05 INFO - moztest == 0.7 04:13:05 INFO - mozversion == 1.4 04:13:05 INFO - psutil == 3.1.1 04:13:05 INFO - requests == 1.2.3 04:13:05 INFO - wsgiref == 0.1.2 04:13:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:05 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:05 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 04:13:05 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 04:13:05 INFO - Using env: {'DISPLAY': ':0', 04:13:05 INFO - 'HOME': '/home/cltbld', 04:13:05 INFO - 'LANG': 'en_US.UTF-8', 04:13:05 INFO - 'LANGUAGE': 'en_US:en', 04:13:05 INFO - 'LOGNAME': 'cltbld', 04:13:05 INFO - 'MAIL': '/var/mail/cltbld', 04:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:05 INFO - 'MOZ_NO_REMOTE': '1', 04:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:05 INFO - 'NO_EM_RESTART': '1', 04:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:05 INFO - 'PWD': '/builds/slave/test', 04:13:05 INFO - 'SHELL': '/bin/bash', 04:13:05 INFO - 'SHLVL': '1', 04:13:05 INFO - 'TERM': 'linux', 04:13:05 INFO - 'TMOUT': '86400', 04:13:05 INFO - 'USER': 'cltbld', 04:13:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:05 INFO - '_': '/tools/buildbot/bin/python'} 04:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:13:05 INFO - Cleaning up... 04:13:05 INFO - Return code: 0 04:13:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:05 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:05 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 04:13:05 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 04:13:05 INFO - Using env: {'DISPLAY': ':0', 04:13:05 INFO - 'HOME': '/home/cltbld', 04:13:05 INFO - 'LANG': 'en_US.UTF-8', 04:13:05 INFO - 'LANGUAGE': 'en_US:en', 04:13:05 INFO - 'LOGNAME': 'cltbld', 04:13:05 INFO - 'MAIL': '/var/mail/cltbld', 04:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:05 INFO - 'MOZ_NO_REMOTE': '1', 04:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:05 INFO - 'NO_EM_RESTART': '1', 04:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:05 INFO - 'PWD': '/builds/slave/test', 04:13:05 INFO - 'SHELL': '/bin/bash', 04:13:05 INFO - 'SHLVL': '1', 04:13:05 INFO - 'TERM': 'linux', 04:13:05 INFO - 'TMOUT': '86400', 04:13:05 INFO - 'USER': 'cltbld', 04:13:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:05 INFO - '_': '/tools/buildbot/bin/python'} 04:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:05 INFO - Downloading/unpacking jsonschema 04:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:07 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:08 INFO - warning: no files found matching '*.txt' 04:13:08 INFO - no previously-included directories found matching 'build' 04:13:08 INFO - no previously-included directories found matching 'dist' 04:13:08 INFO - no previously-included directories found matching '.git*' 04:13:08 INFO - Installing collected packages: jsonschema, functools32 04:13:08 INFO - Running setup.py install for functools32 04:13:08 INFO - warning: no files found matching '*.txt' 04:13:08 INFO - no previously-included directories found matching 'build' 04:13:08 INFO - no previously-included directories found matching 'dist' 04:13:08 INFO - no previously-included directories found matching '.git*' 04:13:08 INFO - Successfully installed jsonschema functools32 04:13:08 INFO - Cleaning up... 04:13:08 INFO - Return code: 0 04:13:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:08 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 0x7f0326105f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:08 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 04:13:08 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 04:13:08 INFO - Using env: {'DISPLAY': ':0', 04:13:08 INFO - 'HOME': '/home/cltbld', 04:13:08 INFO - 'LANG': 'en_US.UTF-8', 04:13:08 INFO - 'LANGUAGE': 'en_US:en', 04:13:08 INFO - 'LOGNAME': 'cltbld', 04:13:08 INFO - 'MAIL': '/var/mail/cltbld', 04:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:08 INFO - 'MOZ_NO_REMOTE': '1', 04:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:08 INFO - 'NO_EM_RESTART': '1', 04:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:08 INFO - 'PWD': '/builds/slave/test', 04:13:08 INFO - 'SHELL': '/bin/bash', 04:13:08 INFO - 'SHLVL': '1', 04:13:08 INFO - 'TERM': 'linux', 04:13:08 INFO - 'TMOUT': '86400', 04:13:08 INFO - 'USER': 'cltbld', 04:13:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:08 INFO - '_': '/tools/buildbot/bin/python'} 04:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:08 INFO - Downloading/unpacking flake8 04:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:11 INFO - no previously-included directories found matching 'docs/_build' 04:13:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:11 INFO - Running setup.py install for pep8 04:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:11 INFO - no previously-included directories found matching 'docs/_build' 04:13:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:11 INFO - Cleaning up... 04:13:11 INFO - Return code: 0 04:13:11 INFO - Running post-action listener: _resource_record_post_action 04:13:11 INFO - Running post-action listener: _start_resource_monitoring 04:13:11 INFO - Starting resource monitoring. 04:13:11 INFO - ##### 04:13:11 INFO - ##### Running install step. 04:13:11 INFO - ##### 04:13:11 INFO - Running pre-action listener: _resource_record_pre_action 04:13:11 INFO - Running main action method: install 04:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:11 INFO - Reading from file tmpfile_stdout 04:13:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:11 INFO - Reading from file tmpfile_stdout 04:13:11 INFO - Output received: 04:13:11 INFO - Usage: mozinstall [options] installer 04:13:11 INFO - Options: 04:13:11 INFO - -h, --help show this help message and exit 04:13:11 INFO - -d DEST, --destination=DEST 04:13:11 INFO - Directory to install application into. [default: 04:13:11 INFO - "/builds/slave/test"] 04:13:11 INFO - --app=APP Application being installed. [default: firefox] 04:13:11 INFO - mkdir: /builds/slave/test/build/application 04:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:27 INFO - Reading from file tmpfile_stdout 04:13:27 INFO - Output received: 04:13:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:27 INFO - Running post-action listener: _resource_record_post_action 04:13:27 INFO - ##### 04:13:27 INFO - ##### Running run-tests step. 04:13:27 INFO - ##### 04:13:27 INFO - Running pre-action listener: _resource_record_pre_action 04:13:27 INFO - Running main action method: run_tests 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:27 INFO - Python 2.7.3 04:13:27 INFO - Return code: 0 04:13:27 INFO - grabbing minidump binary from tooltool 04:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:27 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 0x1770410>, '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 0x1771310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17717a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:13:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:27 INFO - Return code: 0 04:13:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:13:28 INFO - Return code: 0 04:13:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:13:28 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:13:28 INFO - Using env: {'DISPLAY': ':0', 04:13:28 INFO - 'HOME': '/home/cltbld', 04:13:28 INFO - 'LANG': 'en_US.UTF-8', 04:13:28 INFO - 'LANGUAGE': 'en_US:en', 04:13:28 INFO - 'LOGNAME': 'cltbld', 04:13:28 INFO - 'MAIL': '/var/mail/cltbld', 04:13:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:28 INFO - 'MOZ_NO_REMOTE': '1', 04:13:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:28 INFO - 'NO_EM_RESTART': '1', 04:13:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:28 INFO - 'PWD': '/builds/slave/test', 04:13:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:28 INFO - 'SHELL': '/bin/bash', 04:13:28 INFO - 'SHLVL': '1', 04:13:28 INFO - 'TERM': 'linux', 04:13:28 INFO - 'TMOUT': '86400', 04:13:28 INFO - 'USER': 'cltbld', 04:13:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133', 04:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:28 INFO - '_': '/tools/buildbot/bin/python'} 04:13:28 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:13:28 INFO - mozversion application_buildid: 20160404093933 04:13:28 INFO - mozversion application_changeset: b3501e6ad98af3c4e6833bcc2725f374f171805b 04:13:28 INFO - mozversion application_display_name: Nightly 04:13:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:28 INFO - mozversion application_name: Firefox 04:13:28 INFO - mozversion application_remotingname: firefox 04:13:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:13:28 INFO - mozversion application_vendor: Mozilla 04:13:28 INFO - mozversion application_version: 48.0a1 04:13:28 INFO - mozversion platform_buildid: 20160404093933 04:13:28 INFO - mozversion platform_changeset: b3501e6ad98af3c4e6833bcc2725f374f171805b 04:13:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:13:28 INFO - mozversion platform_version: 48.0a1 04:13:28 INFO - using testdate: 1459854808 04:13:28 INFO - actual date: 1459854808 04:13:28 INFO - starting webserver on 'localhost:38292' 04:13:28 INFO - SUITE-START | Running 2 tests 04:13:28 INFO - TEST-START | dromaeo_css 04:13:28 INFO - operating with platform_type : linux_ 04:13:28 INFO - Initialising browser for dromaeo_css test... 04:13:28 INFO - TEST-INFO | started process 22524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRz0KYJ/profile http://localhost:38292/getInfo.html) 04:13:32 INFO - PROCESS | 22524 | __metrics Screen width/height:1600/1200 04:13:32 INFO - PROCESS | 22524 | colorDepth:24 04:13:32 INFO - PROCESS | 22524 | Browser inner width/height: 1024/697 04:13:32 INFO - PROCESS | 22524 | __metrics 04:13:33 ERROR - PROCESS | 22524 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:13:34 INFO - TEST-INFO | 22524: exit 0 04:13:34 INFO - Browser initialized. 04:13:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:34 INFO - TEST-INFO | started process 22605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRz0KYJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:46 INFO - PROCESS | 22605 | RSS: Main: 154333184 04:13:46 INFO - PROCESS | 22605 | 04:14:37 INFO - PROCESS | 22605 | 1459854877089 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:16:47 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38292/tests/dromaeo/cssquery-ext.html) 04:16:49 INFO - PROCESS | 22605 | RSS: Main: 261599232 04:16:49 INFO - PROCESS | 22605 | 04:19:51 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-ext.html (next: http://localhost:38292/tests/dromaeo/cssquery-jquery.html) 04:19:51 INFO - PROCESS | 22605 | RSS: Main: 233525248 04:19:51 INFO - PROCESS | 22605 | 04:22:54 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38292/tests/dromaeo/cssquery-mootools.html) 04:22:54 INFO - PROCESS | 22605 | RSS: Main: 233598976 04:22:54 INFO - PROCESS | 22605 | 04:25:56 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38292/tests/dromaeo/cssquery-prototype.html) 04:25:57 INFO - PROCESS | 22605 | RSS: Main: 216842240 04:25:57 INFO - PROCESS | 22605 | 04:28:59 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38292/tests/dromaeo/cssquery-yui.html) 04:29:00 INFO - PROCESS | 22605 | RSS: Main: 198750208 04:29:00 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | Cycle 1(1): loaded http://localhost:38292/tests/dromaeo/cssquery-yui.html (next: http://localhost:38292/tests/dromaeo/cssquery-dojo.html) 04:32:03 INFO - PROCESS | 22605 | RSS: Main: 264077312 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | __start_tp_report 04:32:03 INFO - PROCESS | 22605 | _x_x_mozilla_page_load 04:32:03 INFO - PROCESS | 22605 | _x_x_mozilla_page_load_details 04:32:03 INFO - PROCESS | 22605 | |i|pagename|runs| 04:32:03 INFO - PROCESS | 22605 | |0;dojo.html;2572.742725727427;2626.868656567171;2637.2747494439013;2650.3771613670783;2677.825941313815;4429.047754732732;4501.437320334958;4504.504504504502;4513.119941611383;4550.271956486963;4480.97759511202;4486.618637415815;4506.797194126264;4585.174668559658;4590.127875703614;4162.7502349859105;4181.665466762667;4199.475065616798;4225.345071513905;4293.849715259967;4230;4240.3851441540955;4314.503832059322;4346.521882592912;4356.520782713915;4075.2664520386616;4254.127903779718;4286.014216730154;4299.07569872479;4304.7632380219075;4135.524414692319;4174.645155161815;4183.435236243129;4199.643030342425;4226.006888381258;4152.252594532983;4185.142045880587;4189.790510474464;4203.054312779631;4235;4345.543717909637;4443.155800397914;4445.755483448409;4448.466184057901;4491.955080449186;4862.5380588844;4886.389201349832;4892.877678058077;4907.460179380265;4940.481249468826;4865.854024379274;4875.24433712775;4877.317175595419;4881.487443818383;4917.336159618477;4490.281554951192;4540.296254080623;4560.338750881104;4564.794584243684;4613.492515823256;4953.6037117030555;4970.353853998957;4972.602191824645;4997.9750101249265;5028.723420211851;4768.9523104769205;4771.117343291502;4772.856814295507;4773.570378665937;4822.180229360947;4760.571548560646;4777.761111944389;4839.491853355417;4857.635677324215;4899.657024008286;4794.017226468565;4807.831725889647;4836.032793441326;4853.6602437829715;4859.2954021666665;4813.253945638432;4814.518548145227;4815.831445899376;4822.083804077214;4863.148948933923;3820.025893397166;3859.0931131184147;3874.2251549689613;3890.2025084857537;3914.784686842251;3422.4866270059692;3454.2055327274866;3490.110021944439;3521.084518025332;3537.646235376442;4142.647874930664;4146.792660366969;4148.460700109027;4152.792360381969;4189.476315460567;4755.714657120584;4783.043391321749;4821.2045012573235;4821.228603423436;4865.9756701216265;4184.979075104605;4186.204621121977;4197.307444271661;4228.492580890313;4231.851885184004;4402.823887044482;4436.3567282743825;4448.1770872388715;4448.4439445069365;4488.640908727294;4517.232070547949;4611.077784443125;4618.353430519663;4660.254359302496;4694.483606803181;4873.7806798694855;4876.024795041077;4881.267809828554;4908.042931628298;4912.287718280901;4628.328892310664;4635.304704294248;4643.598339719072;4644.442666879996;4672.906541869075;4664.090502352009;4789.544993225638;4804.663673542818;4857.271409288635;4870.537298956593;4849.442314133919;4850.320955066223;4872.3909511311085;4873.342098816614;4914.8279810207905;4721.527847215251;4737.502562230916;4738;4741;4785.066911952136;4677.625789936729;4715.599174070242;4762.571368576845;4780.067886762048;4798.448178459522;4594.035252596858;4640.3735495709;4645.187092258773;4654.627629789677;4704.764761761967;4626.5604767548375;4702.741349225688;4704.059188162313;4706.341112244357;4750.14497390473;4608.446986361658;4646.883827904329;4651.813927442864;4694.131585656664;4698.600618947427 04:32:03 INFO - PROCESS | 22605 | |1;ext.html;531.9574434045276;547.3923944421691;571.3343954293249;582.1239035251945;592.3306663470283;34179.316413671746;34805.30389392211;34818.129546761345;34881.12797180072;34920.12699682506;35785.46321805175;36329.45505817415;36333.09167270819;36413.81793091037;36491.4526282106;7575.9621201893915;7733.265339792739;7738;7771.611419429034;7777.2222777722345;7651.1583725790115;7910.80222994424;7929.643166057513;7970.242826931461;7971.003624546932;7903.0911445183965;7982.161873003338;7982.481138725993;7986.321162701177;7986.6805327786815;7872.055353357605;7931.127575966639;7933.167017463141;7946.443748937577;7949.920500794976;7759.185285544993;7859.52842829432;7864.803379915491;7871.016122984627;7878.330341920943;35955.28089438197;36430.27139457223;36482;36528.45207321892;36535.26929461396;2215.5901158285606;2261.8869056547105;2964.5553167024905;2986.059391291736;3223.8065716057113;25935.740642593522;27553.448931021267;28536.571951420745;28563.57154642682;28663.57004644932;3400.4219282721997;3499.2826470573473;3506.5792104947313;3546.308469848381;3556.5554305711785;159622;159709;160420;160810;161197;48582.75708621434;54674.179887301725;55151.44848551544;55169.724151378985;57084.42915570791;53408;53481.465185347646;53595.732021340424;53596.464035359924;53683.19475207875;14127.293635318192;14441.277936103153;14454.421823126957;14454.494092706705;14473.203973781332;10833.78332433347;10912.836307455236;10916.235863489639;10918.672439826818;10921;18334.81665183358;19139.904300478407;19149.712754308697;19195.80804191968;19260;6990.860182796316;7046.154461464657;7211.932306339816;7311.634418279064;7334.559926404326;876.6055275126218;877.9780505487414;884.6063501741663;1001.6944831826218;1005.9547320370601;28035.43929121447;28170;28308.292292692848;28456.28859278493;28877.133685989455;973.4110862927968;975.5707488704948;978.6574698855344;978.9167920726818;1052.921030922684;14774.039687420283;14962.476313328982;15027.924860375846;15192.316345764468;15281.541553753405;232612;236220;236225;236430;358366;50345.49654503408;50970;51104.74447627812;51121;51142.74428627833;1093;1212.7200862378847;1220.877912208772;1225.3811825028304;1301.284293638495;26847.865760671073;27780.861095694392;28031.57952630753;28136.71863281341;28167.57748633731;39365.80317098396;39589.40615890821;39788.40317395183;39935.2012959745;39973;261101;266100;266142;266335;267702;33026.504602430505;33436.33127337391;33472;40695.796521017204;41616.3757543631;42829.48057651595;43684.56315436805;43874.12251755011;44432.777836111905;44750.3287450682;34464.483032754026;34583.65416345905;35349.646503534634;37638;38149.23701525899;36830.63169368379;36902.26195476129;37039.629603703615;37231.06922326964;37402.625973741;36069.27861442704;36759.63240367562;37053.629463705016;37479;37769.244615108095;31959.360812784078;33308;33361;33420.66579334273;33556.328873422884;25756.356091097125;26336.868315659067;26393.472130556896;26435.159090795514;26574.601380978915 04:32:03 INFO - PROCESS | 22605 | |2;jquery.html;340.36521886681345;342.89198902345765;343.2328745254356;346.91500582357327;354.5638864197039;15431.691366172683;15957.361705531765;16222.918885405586;16549.83450165498;16782.244798984044;10312.1234695051;10676.572937082507;10677.572897084126;15249.84750152498;15434.845651543481;4471.776411179436;4587;4598.0344127733215;4599.563041511051;4600.470945841238;3498.1604414940484;3676.724245681571;3820.102275965146;4607.470140933785;5989.8203053908455;5942.6434413935085;5971.07448345505;5972.970135149319;5974.522038236931;5979.970100149515;5502.724863756796;5504.256925315071;5575.581831362644;5912.467877890989;6040.939590604104;5178.456262092502;5273.789048438058;5278.366596008465;5293.523582877521;5308.0710875596615;11965.641030769091;12295.754084918251;12358.196717213352;12486.50053997839;12488.81266780999;1827.7075667893207;1866.1229222265513;1991.3627639155477;2062.711220429141;2366.4675448024227;9006.954965225132;9087.545622718904;9427.104425079606;11623.76752464946;12879.935600321938;1634.321756471063;1770.6281680847037;1921.03948025987;1962.744843170393;1976.6837306030966;49352.423229834945;53156.73421632906;57985.420145798846;57986.42013579852;72022.27977720209;14415.35126014144;14581;14786.334614942354;14824.03643763152;15019.173945432887;24793.256202313598;24896.87551562267;25033.499330013663;25078.37304067413;25121;7761.758118701094;8216.589170541449;8274.462159959703;8406.957965210135;8536.573171341408;6915;6978.232394436608;7030.929690703129;7076.150861896605;7139.250378710264;7516.812079698051;7630;7734.613269336511;7819.5699236541395;7832.216778322236;3079.90760277192;3117.6570577236484;3182.5067114597273;3198.3283510462597;3205.8557364918634;676.2155899156954;713.6931119618614;768.1895600141904;792.9493421216911;796.6614188969664;13670.589882303548;14010.509632162826;14019.789703154462;14129.293535323193;14148.646283842987;673.6126727131821;703.7888633409957;721.9963900180466;773.9380849532024;780.5394817057963;7918.762437126896;7962.6416811243635;7982.760517184493;8018.879716804253;8079.272865442138;381729;382664;396099;411264;413243;67495.66252168707;69305.30694692988;69627;69682;70608.29391706017;828.7016673997356;904.8235594059096;928.9303302252223;943.9386439881386;944.3719926248967;14545.200083972475;14648;14704.632384190481;14758.63103422423;14775.408983640535;29949;30952.226194345323;31480.212994675316;31846.840765796023;32879.83560082184;43595;44225.33661995008;44250.778746106065;44345.55654443414;44979.77510112429;7330.193678695446;7516.098068231847;7560.886586701094;7610.771676849703;7690.692372305045;10823.296485728402;11096.389698566656;11104.167187460811;11226.831597526207;11616;9504.762380940256;9867.16129129032;9922.156616687662;9964.850527241952;10110.443925584164;9556.331056825955;9748;9779.755506112404;9903.653372131941;10186.286959912735;9777.755556111155;9934.503274836085;9935.65225217114;10055.39667619945;10235.590576377159;7399.112106547249;7459.701611935679;7472.402207823252;7529.284717951786;7552.358049565849;9898.20814334837;9977.201823854219;10067.647632332833;10075.949620251851;10191.745206369604 04:32:03 INFO - PROCESS | 22605 | |3;mootools.html;1387.4796951143321;1429.3996521460986;1557.423753211312;1730.9873723871535;1781.3854220294002;6988.895166572499;7115.3951914087365;7156.17703964043;7167.068281123453;7174.174969878465;6275.090111933767;6874.79375618731;6997.3002699730005;7011.544249623784;7055.365017148456;2220.6335954567517;2250.7299124105048;2254.785795349439;2258.9096436142536;2261.332906792492;2195.089038049208;2210.0938615167784;2248.910043598254;2253.0649780341137;2256.954860902781;1909.3699079303797;1957.6476234277825;1962.2739586353068;2146.377550510358;2186.2238905188588;2159.1795117855195;2174.749903761072;2182.7271591051117;2185.158713895146;2187.507810742586;2087.1755656515743;2187.8359123065675;2190.671399290103;2192.506685995654;2194.594000109969;7058.54119482232;7220.783376498714;7228.638568071628;7249.637518124073;7252.129744430649;4335.631471324941;4475.776211189427;4480.059187570614;4480.215962206634;4483.955160448387;2875.0368626510144;2925.049358958347;2943.793934424591;2951.5720220568114;2955.157780032702;922.9769255768659;989.1493315748451;1010.4493051287067;1024.262530977695;1028.7530992561806;9207.585658645377;9336.533173341306;9372.812543749154;9392.201662858664;9411.811763764823;3827.502424684829;3844.596317386634;3905.941410878839;3925.0187453136714;3960.2277555876904;7826.02174728159;7839.294463498312;7849.1758365370815;7853.096893857165;7858.0570331560575;4431.091626216617;4450.109978004412;4457.821687132543;4461.843835465808;4479.193745125844;4138.8551400700835;4148.377743338463;4184.748915065105;4189.72766770159;4191.077962848169;3141.874325026973;3233.9676603233665;3255.088575198901;3255.8372081395837;3259.9837000814846;965.7392504023874;990.1880458024351;990.4948476277151;1000.1548691355792;1001.0590045357341;774.0904437286279;933.3932943586587;964.1178321835582;996.6960077176531;1014.8832884218409;6478.255000674889;6510.251321098134;6560;6579.736810527525;6579.868402632016;992.831218692824;997.9650712225183;1030.701096681954;1060.7825395793843;1084.4577711144427;5223.164293713064;5300;5340.092184328673;5342.893142137135;5354.250404943311;8674.04585495595;8775.210231079234;9000.954995224982;9015.459072455673;9135.817283654289;8855.822883542292;8987.910120898707;9014.233790127913;9016.729498115066;9055.139761722627;6899.931000689929;7034.964825175944;7075.115610548682;7090.6100164491445;7121.109861267341;6476;6501.837454063497;6506.25178104524;6563.442107420923;6567.605943643397;7844.4116691247245;7872.527648341118;7930.524168549906;8001.959990200012;8125.75622731319;7960;8207.261346478846;8210.753677389688;8355.080941096596;8366.288865446506;6016.278046634432;6019.067044608093;6065.5754097212775;6077;6086.147939288591;6893.0694356261265;6992.300769922967;7020.508564400648;7042.894356584758;7050.330218629222;6124.938750612437;6146.139540464249;6226.128342032029;6280.905786413116;6330.208723909512;5010.799568017239;6125.418085281891;6176.4441200292185;6267.874642507033;6401.263854656588;6586.5389422739945;6588.538802283794;6633.1045308882685;6657.3009833966735;6692.866142677217;5940.3168635605725;5959.463648271676;6017.699115044318;6040.546958978006;6043.546733995056;6100.206973093469;6222.62664240147;6275.560710750204;6277.089821975696;6311.211098612674 04:32:03 INFO - PROCESS | 22605 | |4;prototype.html;299.5581517262038;304.7546724886467;309.18221304649205;316.357793678832;317.59506629047974;5135.178371460567;5266.34170728659;5300.072487314719;5340.599455040868;5382.6232163748555;5229.111051121309;5277.575054735219;5289.788408463666;5291.074062039147;5300.443453437391;3849.2301539692176;3912.823922923461;4017.236725022251;4076.347784354504;4083.1425400665894;4018.095928416112;4025.8389664413535;4029.516458025041;4031.717779755418;4034.435179074917;3984.4222587724907;3984.9203015939665;3986.820593073319;3990.38149086892;3990.4413382126527;3807.667316439252;3886.805659717031;3956.9802150989062;3982.9601703983026;3987.441758153861;3436.467347561132;3443.276911848515;3447.6552344765573;3449.913752156191;3457.2048428861253;4999.625028122905;5006.874828129289;5010.849674509771;5016.724080175589;5024.296598476216;4585.105904348653;4589.609883159936;4594.88512787183;4596.954030459686;4601.148787474294;5530.004599172147;5531.225628412026;5532.917006244909;5538.861528461781;5547.057000309957;3793.620637936212;3801.7718936863876;3803.2013277211818;3803.410471376941;3806.200697853454;5684.8010319638615;5783.074708046693;5810.941890581083;5844.327902291248;5860.70696465175;3917.804109794499;3928.5071672764166;3929.174873276587;3933.252681990413;3935.5080614923136;3985.621365970286;3990.1221731219084;3992.261431635157;3994.08136128692;3995.340768773178;4584.266517357207;4588;4589.357489951342;4593.747343896051;4595.448546174481;5545.390007099216;5558.972205138948;5560.138178582326;5571.470710282517;5572.498475137257;1368.1244003837553;1391.596437033249;1393.6724869655623;1395.818543589327;1396.1134679478605;855.2003876375609;883.4037025008093;914.1726737302752;933.7992331648728;936.8547875079373;4792.808287668524;4825.5898248648555;4844.442889067732;4859.805607775649;4875.878103047452;5745.080787074048;5810.709464526757;5818.127280907897;5826.504747096545;5833.504152147115;4925.359703238628;4932.062908047531;4934.210526315772;4941.555260026615;4942.5304596063315;3075;3110.751139908802;3111.0822307419367;3115.5638210650527;3116.298832762656;5468.398476167618;5523.530499907472;5524.861878453071;5526.364468086141;5532.917006244909;5797.894161082963;5863.560232982543;5922.733476993546;5956.434138756811;5962.522998160223;5468.890622187613;5499.450054994549;5513.5037846594;5517.4482551745305;5518.144687573433;5783.190353350618;5786.768529258782;5788.623739456922;5796.536277097738;5798.913016304675;5680.801171958961;5693.715314234355;5696.287964004499;5697.914531282117;5698.059820129798;5507.779688812403;5509.3664228612615;5512.5314348280845;5518.91721624184;5523.8066667666435;3890.1052757866414;3992.7005474590105;4024.396340548941;4033.4151548024784;4037.798110094425;5701.287339082614;5723.942760572341;5724.79963201286;5730.255066841451;5731.8567035824435;5517.089680202882;5522.723863806713;5525.944740552543;5526.751296191762;5528.336599608073;5522.806701765419;5526.50261476469;5526.91709624364;5527.585431092603;5536.806211782568;5453.26380938584;5457.890842183055;5460.5904557159165;5476.58925580591;5481.506664400223;5417.51242388187;5559.416261292506;5584.246126772834;5586.385497595343;5587.832365029056;5412.810551630674;5445.59158063139;5456.890862182813;5457.863553411196;5458.099413596871 04:32:03 INFO - PROCESS | 22605 | |5;yui.html;711.8256027273319;729.6096588325244;758.27963434737;777.4557809533328;783.6081959020489;12340.753184936297;12456.688582785435;12501.374931253424;12507.499700012;12535.310557919322;12153.088518361114;12154.69613259669;12159.635210943663;12244.326562039107;12255.448504817283;636.5575924732312;789.2541548236918;795.5266616363255;800.0239707556772;801.6352559585404;800.9359251259914;804.3565147881701;808.0182578167526;810.9837803243931;812.0823469479479;668.7692746002622;835.1648351648352;850.0734199722301;850.9021462531795;852.424613385962;829.854775414303;847.5507980770202;848.3425345357335;848.8472075026493;848.944818586793;619.6468013232459;620.1534904854841;620.4571000374672;622.6015350175891;622.785139127005;12232.755344893141;12263.509459621604;12272.754544909141;12301.630951071482;12309.69225769354;11456.083513318914;12054.15620906528;12060.276383417024;12160.331181784999;12207.938960305142;9901.306908516406;9944.95027524865;9968.601255949754;10034.59861605535;10169.186465082776;3306.504024396336;3317.8296112818243;3344.7491438142238;3382.3573521030926;3420.863165473378;41871.79064104691;42155.57844421578;42253;42390.57609423928;42526.14947701059;9570.521473926276;9864.753381165385;9938.354006989523;10192.643257485952;10193;16988.74516882248;17008;17029.744553831704;17224.933008039116;17236.138193090545;6759.831004224835;6939.20199177091;6957.756478523227;7071.04540886984;7100.573965562083;3515.261795023074;3597.478365636968;3820.102275965146;3829.100161462054;3897.863574774926;2799.566067259578;2886.8845246190335;2902.4485347784275;2905.7239562241552;2925.283305590144;497.93526841510374;509.30988510568386;530.2232229783309;557.8744782423922;561.1386521689187;561.9098948040869;606.5905513778182;633.8732253549308;642.1138828416848;643.5623775832479;7469.51448155879;7668.118166410823;7801.180876008051;7869.763907082796;8011.799705007422;511.6316252298339;529.7430746088144;539.6842846934587;605.3673910763263;606.7652327513489;3625.274945011008;3731.6641502264924;3756.7558108722847;3812.783689262583;3837.213371258885;47557.762211188725;48571;49207;49219.50780492221;49500;39372.60627393689;39508;39843.60156398457;39940;40347.59652403439;35930.820345898625;36108.277834443164;36369.81815090908;36511.81744091315;36617;7990.647778847687;8013.398995075276;8099.14958929304;8203.097659257357;8221.79445513867;31325.216869578442;31723.365532688757;32065.67934320627;32504.512432314008;32926.506102408006;36876.63123368839;37843.243135136596;39803.80098099491;39882;40098.39852402275;10248.846267305848;10378.896211037792;10403.58385664565;10434.217433692655;10436.217283703601;10915.617953371593;11341.886581134084;11347.773044539228;11399;11535.36555489456;8160.240301554883;10592.629257975934;10688.679339619825;11106.222564420414;11119.72200694989;10964.835527466936;11040.558377664804;11042.834357484804;11060.612878549213;11103.666889993314;10622.628208012682;10817.080548153495;10825.945870270598;10834.729131771768;11038.944805275922;9107.041985973048;9118.498482583522;9436.858447123435;9495;9531.475768832503;8973.05782892787;9098.863517047117;9126;9154;9173.312001599774 04:32:03 INFO - PROCESS | 22605 | __end_tp_report 04:32:03 INFO - PROCESS | 22605 | __start_cc_report 04:32:03 INFO - PROCESS | 22605 | _x_x_mozilla_cycle_collect,957 04:32:03 INFO - PROCESS | 22605 | __end_cc_report 04:32:03 INFO - PROCESS | 22605 | __startTimestamp1459855923395__endTimestamp 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | ------- Summary: start ------- 04:32:03 INFO - PROCESS | 22605 | Number of tests: 6 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#0] dojo.html Cycles:165 Average:4488.12 Median:4635.30 stddev:469.01 (10.1%) stddev-sans-first:445.73 04:32:03 INFO - PROCESS | 22605 | Values: 2572.7 2626.9 2637.3 2650.4 2677.8 4429.0 4501.4 4504.5 4513.1 4550.3 4481.0 4486.6 4506.8 4585.2 4590.1 4162.8 4181.7 4199.5 4225.3 4293.8 4230.0 4240.4 4314.5 4346.5 4356.5 4075.3 4254.1 4286.0 4299.1 4304.8 4135.5 4174.6 4183.4 4199.6 4226.0 4152.3 4185.1 4189.8 4203.1 4235.0 4345.5 4443.2 4445.8 4448.5 4492.0 4862.5 4886.4 4892.9 4907.5 4940.5 4865.9 4875.2 4877.3 4881.5 4917.3 4490.3 4540.3 4560.3 4564.8 4613.5 4953.6 4970.4 4972.6 4998.0 5028.7 4769.0 4771.1 4772.9 4773.6 4822.2 4760.6 4777.8 4839.5 4857.6 4899.7 4794.0 4807.8 4836.0 4853.7 4859.3 4813.3 4814.5 4815.8 4822.1 4863.1 3820.0 3859.1 3874.2 3890.2 3914.8 3422.5 3454.2 3490.1 3521.1 3537.6 4142.6 4146.8 4148.5 4152.8 4189.5 4755.7 4783.0 4821.2 4821.2 4866.0 4185.0 4186.2 4197.3 4228.5 4231.9 4402.8 4436.4 4448.2 4448.4 4488.6 4517.2 4611.1 4618.4 4660.3 4694.5 4873.8 4876.0 4881.3 4908.0 4912.3 4628.3 4635.3 4643.6 4644.4 4672.9 4664.1 4789.5 4804.7 4857.3 4870.5 4849.4 4850.3 4872.4 4873.3 4914.8 4721.5 4737.5 4738.0 4741.0 4785.1 4677.6 4715.6 4762.6 4780.1 4798.4 4594.0 4640.4 4645.2 4654.6 4704.8 4626.6 4702.7 4704.1 4706.3 4750.1 4608.4 4646.9 4651.8 4694.1 4698.6 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#1] ext.html Cycles:180 Average:40035.54 Median:36012.28 stddev:61427.97 (170.6%) stddev-sans-first:61528.68 04:32:03 INFO - PROCESS | 22605 | Values: 532.0 547.4 571.3 582.1 592.3 34179.3 34805.3 34818.1 34881.1 34920.1 35785.5 36329.5 36333.1 36413.8 36491.5 7576.0 7733.3 7738.0 7771.6 7777.2 7651.2 7910.8 7929.6 7970.2 7971.0 7903.1 7982.2 7982.5 7986.3 7986.7 7872.1 7931.1 7933.2 7946.4 7949.9 7759.2 7859.5 7864.8 7871.0 7878.3 35955.3 36430.3 36482.0 36528.5 36535.3 2215.6 2261.9 2964.6 2986.1 3223.8 25935.7 27553.4 28536.6 28563.6 28663.6 3400.4 3499.3 3506.6 3546.3 3556.6 159622.0 159709.0 160420.0 160810.0 161197.0 48582.8 54674.2 55151.4 55169.7 57084.4 53408.0 53481.5 53595.7 53596.5 53683.2 14127.3 14441.3 14454.4 14454.5 14473.2 10833.8 10912.8 10916.2 10918.7 10921.0 18334.8 19139.9 19149.7 19195.8 19260.0 6990.9 7046.2 7211.9 7311.6 7334.6 876.6 878.0 884.6 1001.7 1006.0 28035.4 28170.0 28308.3 28456.3 28877.1 973.4 975.6 978.7 978.9 1052.9 14774.0 14962.5 15027.9 15192.3 15281.5 232612.0 236220.0 236225.0 236430.0 358366.0 50345.5 50970.0 51104.7 51121.0 51142.7 1093.0 1212.7 1220.9 1225.4 1301.3 26847.9 27780.9 28031.6 28136.7 28167.6 39365.8 39589.4 39788.4 39935.2 39973.0 261101.0 266100.0 266142.0 266335.0 267702.0 33026.5 33436.3 33472.0 40695.8 41616.4 42829.5 43684.6 43874.1 44432.8 44750.3 34464.5 34583.7 35349.6 37638.0 38149.2 36830.6 36902.3 37039.6 37231.1 37402.6 36069.3 36759.6 37053.6 37479.0 37769.2 31959.4 33308.0 33361.0 33420.7 33556.3 25756.4 26336.9 26393.5 26435.2 26574.6 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#2] jquery.html Cycles:180 Average:23678.42 Median:4600.02 stddev:65110.01 (1415.4%) stddev-sans-first:65269.08 04:32:03 INFO - PROCESS | 22605 | Values: 340.4 342.9 343.2 346.9 354.6 15431.7 15957.4 16222.9 16549.8 16782.2 10312.1 10676.6 10677.6 15249.8 15434.8 4471.8 4587.0 4598.0 4599.6 4600.5 3498.2 3676.7 3820.1 4607.5 5989.8 5942.6 5971.1 5973.0 5974.5 5980.0 5502.7 5504.3 5575.6 5912.5 6040.9 5178.5 5273.8 5278.4 5293.5 5308.1 11965.6 12295.8 12358.2 12486.5 12488.8 1827.7 1866.1 1991.4 2062.7 2366.5 9007.0 9087.5 9427.1 11623.8 12879.9 1634.3 1770.6 1921.0 1962.7 1976.7 49352.4 53156.7 57985.4 57986.4 72022.3 14415.4 14581.0 14786.3 14824.0 15019.2 24793.3 24896.9 25033.5 25078.4 25121.0 7761.8 8216.6 8274.5 8407.0 8536.6 6915.0 6978.2 7030.9 7076.2 7139.3 7516.8 7630.0 7734.6 7819.6 7832.2 3079.9 3117.7 3182.5 3198.3 3205.9 676.2 713.7 768.2 792.9 796.7 13670.6 14010.5 14019.8 14129.3 14148.6 673.6 703.8 722.0 773.9 780.5 7918.8 7962.6 7982.8 8018.9 8079.3 381729.0 382664.0 396099.0 411264.0 413243.0 67495.7 69305.3 69627.0 69682.0 70608.3 828.7 904.8 928.9 943.9 944.4 14545.2 14648.0 14704.6 14758.6 14775.4 29949.0 30952.2 31480.2 31846.8 32879.8 43595.0 44225.3 44250.8 44345.6 44979.8 7330.2 7516.1 7560.9 7610.8 7690.7 10823.3 11096.4 11104.2 11226.8 11616.0 9504.8 9867.2 9922.2 9964.9 10110.4 9556.3 9748.0 9779.8 9903.7 10186.3 9777.8 9934.5 9935.7 10055.4 10235.6 7399.1 7459.7 7472.4 7529.3 7552.4 9898.2 9977.2 10067.6 10075.9 10191.7 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#3] mootools.html Cycles:180 Average:5042.26 Median:6224.38 stddev:2579.90 (41.4%) stddev-sans-first:2572.51 04:32:03 INFO - PROCESS | 22605 | Values: 1387.5 1429.4 1557.4 1731.0 1781.4 6988.9 7115.4 7156.2 7167.1 7174.2 6275.1 6874.8 6997.3 7011.5 7055.4 2220.6 2250.7 2254.8 2258.9 2261.3 2195.1 2210.1 2248.9 2253.1 2257.0 1909.4 1957.6 1962.3 2146.4 2186.2 2159.2 2174.7 2182.7 2185.2 2187.5 2087.2 2187.8 2190.7 2192.5 2194.6 7058.5 7220.8 7228.6 7249.6 7252.1 4335.6 4475.8 4480.1 4480.2 4484.0 2875.0 2925.0 2943.8 2951.6 2955.2 923.0 989.1 1010.4 1024.3 1028.8 9207.6 9336.5 9372.8 9392.2 9411.8 3827.5 3844.6 3905.9 3925.0 3960.2 7826.0 7839.3 7849.2 7853.1 7858.1 4431.1 4450.1 4457.8 4461.8 4479.2 4138.9 4148.4 4184.7 4189.7 4191.1 3141.9 3234.0 3255.1 3255.8 3260.0 965.7 990.2 990.5 1000.2 1001.1 774.1 933.4 964.1 996.7 1014.9 6478.3 6510.3 6560.0 6579.7 6579.9 992.8 998.0 1030.7 1060.8 1084.5 5223.2 5300.0 5340.1 5342.9 5354.3 8674.0 8775.2 9001.0 9015.5 9135.8 8855.8 8987.9 9014.2 9016.7 9055.1 6899.9 7035.0 7075.1 7090.6 7121.1 6476.0 6501.8 6506.3 6563.4 6567.6 7844.4 7872.5 7930.5 8002.0 8125.8 7960.0 8207.3 8210.8 8355.1 8366.3 6016.3 6019.1 6065.6 6077.0 6086.1 6893.1 6992.3 7020.5 7042.9 7050.3 6124.9 6146.1 6226.1 6280.9 6330.2 5010.8 6125.4 6176.4 6267.9 6401.3 6586.5 6588.5 6633.1 6657.3 6692.9 5940.3 5959.5 6017.7 6040.5 6043.5 6100.2 6222.6 6275.6 6277.1 6311.2 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#4] prototype.html Cycles:180 Average:4588.53 Median:5295.57 stddev:1372.32 (25.9%) stddev-sans-first:1337.88 04:32:03 INFO - PROCESS | 22605 | Values: 299.6 304.8 309.2 316.4 317.6 5135.2 5266.3 5300.1 5340.6 5382.6 5229.1 5277.6 5289.8 5291.1 5300.4 3849.2 3912.8 4017.2 4076.3 4083.1 4018.1 4025.8 4029.5 4031.7 4034.4 3984.4 3984.9 3986.8 3990.4 3990.4 3807.7 3886.8 3957.0 3983.0 3987.4 3436.5 3443.3 3447.7 3449.9 3457.2 4999.6 5006.9 5010.8 5016.7 5024.3 4585.1 4589.6 4594.9 4597.0 4601.1 5530.0 5531.2 5532.9 5538.9 5547.1 3793.6 3801.8 3803.2 3803.4 3806.2 5684.8 5783.1 5810.9 5844.3 5860.7 3917.8 3928.5 3929.2 3933.3 3935.5 3985.6 3990.1 3992.3 3994.1 3995.3 4584.3 4588.0 4589.4 4593.7 4595.4 5545.4 5559.0 5560.1 5571.5 5572.5 1368.1 1391.6 1393.7 1395.8 1396.1 855.2 883.4 914.2 933.8 936.9 4792.8 4825.6 4844.4 4859.8 4875.9 5745.1 5810.7 5818.1 5826.5 5833.5 4925.4 4932.1 4934.2 4941.6 4942.5 3075.0 3110.8 3111.1 3115.6 3116.3 5468.4 5523.5 5524.9 5526.4 5532.9 5797.9 5863.6 5922.7 5956.4 5962.5 5468.9 5499.5 5513.5 5517.4 5518.1 5783.2 5786.8 5788.6 5796.5 5798.9 5680.8 5693.7 5696.3 5697.9 5698.1 5507.8 5509.4 5512.5 5518.9 5523.8 3890.1 3992.7 4024.4 4033.4 4037.8 5701.3 5723.9 5724.8 5730.3 5731.9 5517.1 5522.7 5525.9 5526.8 5528.3 5522.8 5526.5 5526.9 5527.6 5536.8 5453.3 5457.9 5460.6 5476.6 5481.5 5417.5 5559.4 5584.2 5586.4 5587.8 5412.8 5445.6 5456.9 5457.9 5458.1 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - PROCESS | 22605 | [#5] yui.html Cycles:180 Average:12204.20 Median:40019.20 stddev:13290.99 (33.2%) stddev-sans-first:13300.25 04:32:03 INFO - PROCESS | 22605 | Values: 711.8 729.6 758.3 777.5 783.6 12340.8 12456.7 12501.4 12507.5 12535.3 12153.1 12154.7 12159.6 12244.3 12255.4 636.6 789.3 795.5 800.0 801.6 800.9 804.4 808.0 811.0 812.1 668.8 835.2 850.1 850.9 852.4 829.9 847.6 848.3 848.8 848.9 619.6 620.2 620.5 622.6 622.8 12232.8 12263.5 12272.8 12301.6 12309.7 11456.1 12054.2 12060.3 12160.3 12207.9 9901.3 9945.0 9968.6 10034.6 10169.2 3306.5 3317.8 3344.7 3382.4 3420.9 41871.8 42155.6 42253.0 42390.6 42526.1 9570.5 9864.8 9938.4 10192.6 10193.0 16988.7 17008.0 17029.7 17224.9 17236.1 6759.8 6939.2 6957.8 7071.0 7100.6 3515.3 3597.5 3820.1 3829.1 3897.9 2799.6 2886.9 2902.4 2905.7 2925.3 497.9 509.3 530.2 557.9 561.1 561.9 606.6 633.9 642.1 643.6 7469.5 7668.1 7801.2 7869.8 8011.8 511.6 529.7 539.7 605.4 606.8 3625.3 3731.7 3756.8 3812.8 3837.2 47557.8 48571.0 49207.0 49219.5 49500.0 39372.6 39508.0 39843.6 39940.0 40347.6 35930.8 36108.3 36369.8 36511.8 36617.0 7990.6 8013.4 8099.1 8203.1 8221.8 31325.2 31723.4 32065.7 32504.5 32926.5 36876.6 37843.2 39803.8 39882.0 40098.4 10248.8 10378.9 10403.6 10434.2 10436.2 10915.6 11341.9 11347.8 11399.0 11535.4 8160.2 10592.6 10688.7 11106.2 11119.7 10964.8 11040.6 11042.8 11060.6 11103.7 10622.6 10817.1 10825.9 10834.7 11038.9 9107.0 9118.5 9436.9 9495.0 9531.5 8973.1 9098.9 9126.0 9154.0 9173.3 04:32:03 INFO - PROCESS | 22605 | -------- Summary: end -------- 04:32:03 INFO - PROCESS | 22605 | 04:32:03 INFO - TEST-INFO | 22605: exit 0 04:32:04 INFO - TEST-OK | dromaeo_css | took 1115520ms 04:32:04 INFO - TEST-START | kraken 04:32:04 INFO - operating with platform_type : linux_ 04:32:04 INFO - Initialising browser for kraken test... 04:32:04 INFO - TEST-INFO | started process 22784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCjDoA/profile http://localhost:38292/getInfo.html) 04:32:08 INFO - PROCESS | 22784 | __metrics Screen width/height:1600/1200 04:32:08 INFO - PROCESS | 22784 | colorDepth:24 04:32:08 INFO - PROCESS | 22784 | Browser inner width/height: 1024/697 04:32:08 INFO - PROCESS | 22784 | __metrics 04:32:08 ERROR - PROCESS | 22784 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:09 INFO - TEST-INFO | 22784: exit 0 04:32:09 INFO - Browser initialized. 04:32:09 INFO - Running cycle 1/1 for kraken test... 04:32:09 INFO - TEST-INFO | started process 22867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaCjDoA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:21 INFO - PROCESS | 22867 | RSS: Main: 154189824 04:32:21 INFO - PROCESS | 22867 | 04:32:24 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38292/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:24 INFO - PROCESS | 22867 | RSS: Main: 195481600 04:32:24 INFO - PROCESS | 22867 | 04:32:27 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38292/tests/kraken/driver.html?testName=audio-dft) 04:32:28 INFO - PROCESS | 22867 | RSS: Main: 186068992 04:32:28 INFO - PROCESS | 22867 | 04:32:31 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38292/tests/kraken/driver.html?testName=audio-fft) 04:32:31 INFO - PROCESS | 22867 | RSS: Main: 170565632 04:32:31 INFO - PROCESS | 22867 | 04:32:33 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38292/tests/kraken/driver.html?testName=audio-oscillator) 04:32:34 INFO - PROCESS | 22867 | RSS: Main: 171298816 04:32:34 INFO - PROCESS | 22867 | 04:32:36 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:37 INFO - PROCESS | 22867 | RSS: Main: 173629440 04:32:37 INFO - PROCESS | 22867 | 04:32:40 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38292/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:41 INFO - PROCESS | 22867 | RSS: Main: 173535232 04:32:41 INFO - PROCESS | 22867 | 04:32:44 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38292/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:44 INFO - PROCESS | 22867 | RSS: Main: 173924352 04:32:44 INFO - PROCESS | 22867 | 04:32:47 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38292/tests/kraken/driver.html?testName=json-parse-financial) 04:32:48 INFO - PROCESS | 22867 | RSS: Main: 174227456 04:32:48 INFO - PROCESS | 22867 | 04:32:50 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:50 INFO - PROCESS | 22867 | RSS: Main: 184025088 04:32:50 INFO - PROCESS | 22867 | 04:32:52 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:53 INFO - PROCESS | 22867 | RSS: Main: 182501376 04:32:53 INFO - PROCESS | 22867 | 04:32:55 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:55 INFO - PROCESS | 22867 | RSS: Main: 190418944 04:32:55 INFO - PROCESS | 22867 | 04:32:58 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:59 INFO - PROCESS | 22867 | RSS: Main: 197013504 04:32:59 INFO - PROCESS | 22867 | 04:33:01 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:02 INFO - PROCESS | 22867 | RSS: Main: 196730880 04:33:02 INFO - PROCESS | 22867 | 04:33:03 INFO - PROCESS | 22867 | Cycle 1(1): loaded http://localhost:38292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38292/tests/kraken/driver.html?testName=ai-astar) 04:33:04 INFO - PROCESS | 22867 | RSS: Main: 259104768 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | __start_tp_report 04:33:04 INFO - PROCESS | 22867 | _x_x_mozilla_page_load 04:33:04 INFO - PROCESS | 22867 | _x_x_mozilla_page_load_details 04:33:04 INFO - PROCESS | 22867 | |i|pagename|runs| 04:33:04 INFO - PROCESS | 22867 | |0;ai-astar;111;113;107;112;113;113;100;111;112;113 04:33:04 INFO - PROCESS | 22867 | |1;audio-beat-detection;155;134;155;184;133;160;163;133;178;132 04:33:04 INFO - PROCESS | 22867 | |2;audio-dft;163;160;161;160;161;162;162;162;162;163 04:33:04 INFO - PROCESS | 22867 | |3;audio-fft;73;74;109;108;74;74;75;116;100;78 04:33:04 INFO - PROCESS | 22867 | |4;audio-oscillator;95;94;146;93;94;95;144;96;94;154 04:33:04 INFO - PROCESS | 22867 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;117;117;119 04:33:04 INFO - PROCESS | 22867 | |6;imaging-darkroom;145;147;145;146;145;146;145;146;146;146 04:33:04 INFO - PROCESS | 22867 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 04:33:04 INFO - PROCESS | 22867 | |8;json-parse-financial;64;66;66;66;64;65;66;74;63;64 04:33:04 INFO - PROCESS | 22867 | |9;json-stringify-tinderbox;63;64;65;65;65;66;64;64;64;64 04:33:04 INFO - PROCESS | 22867 | |10;stanford-crypto-aes;82;87;83;83;82;81;81;82;81;83 04:33:04 INFO - PROCESS | 22867 | |11;stanford-crypto-ccm;116;115;126;124;121;125;142;121;128;132 04:33:04 INFO - PROCESS | 22867 | |12;stanford-crypto-pbkdf2;152;138;139;139;139;131;141;140;142;140 04:33:04 INFO - PROCESS | 22867 | |13;stanford-crypto-sha256-iterative;69;68;70;67;67;67;67;67;70;67 04:33:04 INFO - PROCESS | 22867 | __end_tp_report 04:33:04 INFO - PROCESS | 22867 | __start_cc_report 04:33:04 INFO - PROCESS | 22867 | _x_x_mozilla_cycle_collect,1155 04:33:04 INFO - PROCESS | 22867 | __end_cc_report 04:33:04 INFO - PROCESS | 22867 | __startTimestamp1459855984123__endTimestamp 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | ------- Summary: start ------- 04:33:04 INFO - PROCESS | 22867 | Number of tests: 14 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:4.36 04:33:04 INFO - PROCESS | 22867 | Values: 111.0 113.0 107.0 112.0 113.0 113.0 100.0 111.0 112.0 113.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:157.50 stddev:19.28 (12.2%) stddev-sans-first:20.43 04:33:04 INFO - PROCESS | 22867 | Values: 155.0 134.0 155.0 184.0 133.0 160.0 163.0 133.0 178.0 132.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.01 04:33:04 INFO - PROCESS | 22867 | Values: 163.0 160.0 161.0 160.0 161.0 162.0 162.0 162.0 162.0 163.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#3] audio-fft Cycles:10 Average:88.10 Median:74.00 stddev:17.80 (24.1%) stddev-sans-first:18.02 04:33:04 INFO - PROCESS | 22867 | Values: 73.0 74.0 109.0 108.0 74.0 74.0 75.0 116.0 100.0 78.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:94.00 stddev:26.01 (27.7%) stddev-sans-first:26.98 04:33:04 INFO - PROCESS | 22867 | Values: 95.0 94.0 146.0 93.0 94.0 95.0 144.0 96.0 94.0 154.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:33:04 INFO - PROCESS | 22867 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 119.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:33:04 INFO - PROCESS | 22867 | Values: 145.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:33:04 INFO - PROCESS | 22867 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:3.08 (4.7%) stddev-sans-first:3.20 04:33:04 INFO - PROCESS | 22867 | Values: 64.0 66.0 66.0 66.0 64.0 65.0 66.0 74.0 63.0 64.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 04:33:04 INFO - PROCESS | 22867 | Values: 63.0 64.0 65.0 65.0 65.0 66.0 64.0 64.0 64.0 64.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.78 (2.2%) stddev-sans-first:1.88 04:33:04 INFO - PROCESS | 22867 | Values: 82.0 87.0 83.0 83.0 82.0 81.0 81.0 82.0 81.0 83.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:125.50 stddev:7.90 (6.3%) stddev-sans-first:7.68 04:33:04 INFO - PROCESS | 22867 | Values: 116.0 115.0 126.0 124.0 121.0 125.0 142.0 121.0 128.0 132.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:140.00 stddev:5.13 (3.7%) stddev-sans-first:3.15 04:33:04 INFO - PROCESS | 22867 | Values: 152.0 138.0 139.0 139.0 139.0 131.0 141.0 140.0 142.0 140.0 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - PROCESS | 22867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.30 04:33:04 INFO - PROCESS | 22867 | Values: 69.0 68.0 70.0 67.0 67.0 67.0 67.0 67.0 70.0 67.0 04:33:04 INFO - PROCESS | 22867 | -------- Summary: end -------- 04:33:04 INFO - PROCESS | 22867 | 04:33:04 INFO - TEST-INFO | 22867: exit 0 04:33:04 INFO - TEST-OK | kraken | took 60954ms 04:33:04 INFO - SUITE-END | took 1176s 04:33:05 INFO - Completed test suite (00:19:36) 04:33:05 INFO - javascript benchmark 04:33:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2572.742725727427, 2626.868656567171, 2637.2747494439013, 2650.3771613670783, 2677.825941313815, 4429.047754732732, 4501.437320334958, 4504.504504504502, 4513.119941611383, 4550.271956486963, 4480.97759511202, 4486.618637415815, 4506.797194126264, 4585.174668559658, 4590.127875703614, 4162.7502349859105, 4181.665466762667, 4199.475065616798, 4225.345071513905, 4293.849715259967, 4230.0, 4240.3851441540955, 4314.503832059322, 4346.521882592912, 4356.520782713915, 4075.2664520386616, 4254.127903779718, 4286.014216730154, 4299.07569872479, 4304.7632380219075, 4135.524414692319, 4174.645155161815, 4183.435236243129, 4199.643030342425, 4226.006888381258, 4152.252594532983, 4185.142045880587, 4189.790510474464, 4203.054312779631, 4235.0, 4345.543717909637, 4443.155800397914, 4445.755483448409, 4448.466184057901, 4491.955080449186, 4862.5380588844, 4886.389201349832, 4892.877678058077, 4907.460179380265, 4940.481249468826, 4865.854024379274, 4875.24433712775, 4877.317175595419, 4881.487443818383, 4917.336159618477, 4490.281554951192, 4540.296254080623, 4560.338750881104, 4564.794584243684, 4613.492515823256, 4953.6037117030555, 4970.353853998957, 4972.602191824645, 4997.9750101249265, 5028.723420211851, 4768.9523104769205, 4771.117343291502, 4772.856814295507, 4773.570378665937, 4822.180229360947, 4760.571548560646, 4777.761111944389, 4839.491853355417, 4857.635677324215, 4899.657024008286, 4794.017226468565, 4807.831725889647, 4836.032793441326, 4853.6602437829715, 4859.2954021666665, 4813.253945638432, 4814.518548145227, 4815.831445899376, 4822.083804077214, 4863.148948933923, 3820.025893397166, 3859.0931131184147, 3874.2251549689613, 3890.2025084857537, 3914.784686842251, 3422.4866270059692, 3454.2055327274866, 3490.110021944439, 3521.084518025332, 3537.646235376442, 4142.647874930664, 4146.792660366969, 4148.460700109027, 4152.792360381969, 4189.476315460567, 4755.714657120584, 4783.043391321749, 4821.2045012573235, 4821.228603423436, 4865.9756701216265, 4184.979075104605, 4186.204621121977, 4197.307444271661, 4228.492580890313, 4231.851885184004, 4402.823887044482, 4436.3567282743825, 4448.1770872388715, 4448.4439445069365, 4488.640908727294, 4517.232070547949, 4611.077784443125, 4618.353430519663, 4660.254359302496, 4694.483606803181, 4873.7806798694855, 4876.024795041077, 4881.267809828554, 4908.042931628298, 4912.287718280901, 4628.328892310664, 4635.304704294248, 4643.598339719072, 4644.442666879996, 4672.906541869075, 4664.090502352009, 4789.544993225638, 4804.663673542818, 4857.271409288635, 4870.537298956593, 4849.442314133919, 4850.320955066223, 4872.3909511311085, 4873.342098816614, 4914.8279810207905, 4721.527847215251, 4737.502562230916, 4738.0, 4741.0, 4785.066911952136, 4677.625789936729, 4715.599174070242, 4762.571368576845, 4780.067886762048, 4798.448178459522, 4594.035252596858, 4640.3735495709, 4645.187092258773, 4654.627629789677, 4704.764761761967, 4626.5604767548375, 4702.741349225688, 4704.059188162313, 4706.341112244357, 4750.14497390473, 4608.446986361658, 4646.883827904329, 4651.813927442864, 4694.131585656664, 4698.600618947427], "unit": "score", "name": "dojo.html", "value": 4458.820461333465}, {"lowerIsBetter": false, "replicates": [531.9574434045276, 547.3923944421691, 571.3343954293249, 582.1239035251945, 592.3306663470283, 34179.316413671746, 34805.30389392211, 34818.129546761345, 34881.12797180072, 34920.12699682506, 35785.46321805175, 36329.45505817415, 36333.09167270819, 36413.81793091037, 36491.4526282106, 7575.9621201893915, 7733.265339792739, 7738.0, 7771.611419429034, 7777.2222777722345, 7651.1583725790115, 7910.80222994424, 7929.643166057513, 7970.242826931461, 7971.003624546932, 7903.0911445183965, 7982.161873003338, 7982.481138725993, 7986.321162701177, 7986.6805327786815, 7872.055353357605, 7931.127575966639, 7933.167017463141, 7946.443748937577, 7949.920500794976, 7759.185285544993, 7859.52842829432, 7864.803379915491, 7871.016122984627, 7878.330341920943, 35955.28089438197, 36430.27139457223, 36482.0, 36528.45207321892, 36535.26929461396, 2215.5901158285606, 2261.8869056547105, 2964.5553167024905, 2986.059391291736, 3223.8065716057113, 25935.740642593522, 27553.448931021267, 28536.571951420745, 28563.57154642682, 28663.57004644932, 3400.4219282721997, 3499.2826470573473, 3506.5792104947313, 3546.308469848381, 3556.5554305711785, 159622.0, 159709.0, 160420.0, 160810.0, 161197.0, 48582.75708621434, 54674.179887301725, 55151.44848551544, 55169.724151378985, 57084.42915570791, 53408.0, 53481.465185347646, 53595.732021340424, 53596.464035359924, 53683.19475207875, 14127.293635318192, 14441.277936103153, 14454.421823126957, 14454.494092706705, 14473.203973781332, 10833.78332433347, 10912.836307455236, 10916.235863489639, 10918.672439826818, 10921.0, 18334.81665183358, 19139.904300478407, 19149.712754308697, 19195.80804191968, 19260.0, 6990.860182796316, 7046.154461464657, 7211.932306339816, 7311.634418279064, 7334.559926404326, 876.6055275126218, 877.9780505487414, 884.6063501741663, 1001.6944831826218, 1005.9547320370601, 28035.43929121447, 28170.0, 28308.292292692848, 28456.28859278493, 28877.133685989455, 973.4110862927968, 975.5707488704948, 978.6574698855344, 978.9167920726818, 1052.921030922684, 14774.039687420283, 14962.476313328982, 15027.924860375846, 15192.316345764468, 15281.541553753405, 232612.0, 236220.0, 236225.0, 236430.0, 358366.0, 50345.49654503408, 50970.0, 51104.74447627812, 51121.0, 51142.74428627833, 1093.0, 1212.7200862378847, 1220.877912208772, 1225.3811825028304, 1301.284293638495, 26847.865760671073, 27780.861095694392, 28031.57952630753, 28136.71863281341, 28167.57748633731, 39365.80317098396, 39589.40615890821, 39788.40317395183, 39935.2012959745, 39973.0, 261101.0, 266100.0, 266142.0, 266335.0, 267702.0, 33026.504602430505, 33436.33127337391, 33472.0, 40695.796521017204, 41616.3757543631, 42829.48057651595, 43684.56315436805, 43874.12251755011, 44432.777836111905, 44750.3287450682, 34464.483032754026, 34583.65416345905, 35349.646503534634, 37638.0, 38149.23701525899, 36830.63169368379, 36902.26195476129, 37039.629603703615, 37231.06922326964, 37402.625973741, 36069.27861442704, 36759.63240367562, 37053.629463705016, 37479.0, 37769.244615108095, 31959.360812784078, 33308.0, 33361.0, 33420.66579334273, 33556.328873422884, 25756.356091097125, 26336.868315659067, 26393.472130556896, 26435.159090795514, 26574.601380978915], "unit": "score", "name": "ext.html", "value": 17139.526619364995}, {"lowerIsBetter": false, "replicates": [340.36521886681345, 342.89198902345765, 343.2328745254356, 346.91500582357327, 354.5638864197039, 15431.691366172683, 15957.361705531765, 16222.918885405586, 16549.83450165498, 16782.244798984044, 10312.1234695051, 10676.572937082507, 10677.572897084126, 15249.84750152498, 15434.845651543481, 4471.776411179436, 4587.0, 4598.0344127733215, 4599.563041511051, 4600.470945841238, 3498.1604414940484, 3676.724245681571, 3820.102275965146, 4607.470140933785, 5989.8203053908455, 5942.6434413935085, 5971.07448345505, 5972.970135149319, 5974.522038236931, 5979.970100149515, 5502.724863756796, 5504.256925315071, 5575.581831362644, 5912.467877890989, 6040.939590604104, 5178.456262092502, 5273.789048438058, 5278.366596008465, 5293.523582877521, 5308.0710875596615, 11965.641030769091, 12295.754084918251, 12358.196717213352, 12486.50053997839, 12488.81266780999, 1827.7075667893207, 1866.1229222265513, 1991.3627639155477, 2062.711220429141, 2366.4675448024227, 9006.954965225132, 9087.545622718904, 9427.104425079606, 11623.76752464946, 12879.935600321938, 1634.321756471063, 1770.6281680847037, 1921.03948025987, 1962.744843170393, 1976.6837306030966, 49352.423229834945, 53156.73421632906, 57985.420145798846, 57986.42013579852, 72022.27977720209, 14415.35126014144, 14581.0, 14786.334614942354, 14824.03643763152, 15019.173945432887, 24793.256202313598, 24896.87551562267, 25033.499330013663, 25078.37304067413, 25121.0, 7761.758118701094, 8216.589170541449, 8274.462159959703, 8406.957965210135, 8536.573171341408, 6915.0, 6978.232394436608, 7030.929690703129, 7076.150861896605, 7139.250378710264, 7516.812079698051, 7630.0, 7734.613269336511, 7819.5699236541395, 7832.216778322236, 3079.90760277192, 3117.6570577236484, 3182.5067114597273, 3198.3283510462597, 3205.8557364918634, 676.2155899156954, 713.6931119618614, 768.1895600141904, 792.9493421216911, 796.6614188969664, 13670.589882303548, 14010.509632162826, 14019.789703154462, 14129.293535323193, 14148.646283842987, 673.6126727131821, 703.7888633409957, 721.9963900180466, 773.9380849532024, 780.5394817057963, 7918.762437126896, 7962.6416811243635, 7982.760517184493, 8018.879716804253, 8079.272865442138, 381729.0, 382664.0, 396099.0, 411264.0, 413243.0, 67495.66252168707, 69305.30694692988, 69627.0, 69682.0, 70608.29391706017, 828.7016673997356, 904.8235594059096, 928.9303302252223, 943.9386439881386, 944.3719926248967, 14545.200083972475, 14648.0, 14704.632384190481, 14758.63103422423, 14775.408983640535, 29949.0, 30952.226194345323, 31480.212994675316, 31846.840765796023, 32879.83560082184, 43595.0, 44225.33661995008, 44250.778746106065, 44345.55654443414, 44979.77510112429, 7330.193678695446, 7516.098068231847, 7560.886586701094, 7610.771676849703, 7690.692372305045, 10823.296485728402, 11096.389698566656, 11104.167187460811, 11226.831597526207, 11616.0, 9504.762380940256, 9867.16129129032, 9922.156616687662, 9964.850527241952, 10110.443925584164, 9556.331056825955, 9748.0, 9779.755506112404, 9903.653372131941, 10186.286959912735, 9777.755556111155, 9934.503274836085, 9935.65225217114, 10055.39667619945, 10235.590576377159, 7399.112106547249, 7459.701611935679, 7472.402207823252, 7529.284717951786, 7552.358049565849, 9898.20814334837, 9977.201823854219, 10067.647632332833, 10075.949620251851, 10191.745206369604], "unit": "score", "name": "jquery.html", "value": 8170.450482292088}, {"lowerIsBetter": false, "replicates": [1387.4796951143321, 1429.3996521460986, 1557.423753211312, 1730.9873723871535, 1781.3854220294002, 6988.895166572499, 7115.3951914087365, 7156.17703964043, 7167.068281123453, 7174.174969878465, 6275.090111933767, 6874.79375618731, 6997.3002699730005, 7011.544249623784, 7055.365017148456, 2220.6335954567517, 2250.7299124105048, 2254.785795349439, 2258.9096436142536, 2261.332906792492, 2195.089038049208, 2210.0938615167784, 2248.910043598254, 2253.0649780341137, 2256.954860902781, 1909.3699079303797, 1957.6476234277825, 1962.2739586353068, 2146.377550510358, 2186.2238905188588, 2159.1795117855195, 2174.749903761072, 2182.7271591051117, 2185.158713895146, 2187.507810742586, 2087.1755656515743, 2187.8359123065675, 2190.671399290103, 2192.506685995654, 2194.594000109969, 7058.54119482232, 7220.783376498714, 7228.638568071628, 7249.637518124073, 7252.129744430649, 4335.631471324941, 4475.776211189427, 4480.059187570614, 4480.215962206634, 4483.955160448387, 2875.0368626510144, 2925.049358958347, 2943.793934424591, 2951.5720220568114, 2955.157780032702, 922.9769255768659, 989.1493315748451, 1010.4493051287067, 1024.262530977695, 1028.7530992561806, 9207.585658645377, 9336.533173341306, 9372.812543749154, 9392.201662858664, 9411.811763764823, 3827.502424684829, 3844.596317386634, 3905.941410878839, 3925.0187453136714, 3960.2277555876904, 7826.02174728159, 7839.294463498312, 7849.1758365370815, 7853.096893857165, 7858.0570331560575, 4431.091626216617, 4450.109978004412, 4457.821687132543, 4461.843835465808, 4479.193745125844, 4138.8551400700835, 4148.377743338463, 4184.748915065105, 4189.72766770159, 4191.077962848169, 3141.874325026973, 3233.9676603233665, 3255.088575198901, 3255.8372081395837, 3259.9837000814846, 965.7392504023874, 990.1880458024351, 990.4948476277151, 1000.1548691355792, 1001.0590045357341, 774.0904437286279, 933.3932943586587, 964.1178321835582, 996.6960077176531, 1014.8832884218409, 6478.255000674889, 6510.251321098134, 6560.0, 6579.736810527525, 6579.868402632016, 992.831218692824, 997.9650712225183, 1030.701096681954, 1060.7825395793843, 1084.4577711144427, 5223.164293713064, 5300.0, 5340.092184328673, 5342.893142137135, 5354.250404943311, 8674.04585495595, 8775.210231079234, 9000.954995224982, 9015.459072455673, 9135.817283654289, 8855.822883542292, 8987.910120898707, 9014.233790127913, 9016.729498115066, 9055.139761722627, 6899.931000689929, 7034.964825175944, 7075.115610548682, 7090.6100164491445, 7121.109861267341, 6476.0, 6501.837454063497, 6506.25178104524, 6563.442107420923, 6567.605943643397, 7844.4116691247245, 7872.527648341118, 7930.524168549906, 8001.959990200012, 8125.75622731319, 7960.0, 8207.261346478846, 8210.753677389688, 8355.080941096596, 8366.288865446506, 6016.278046634432, 6019.067044608093, 6065.5754097212775, 6077.0, 6086.147939288591, 6893.0694356261265, 6992.300769922967, 7020.508564400648, 7042.894356584758, 7050.330218629222, 6124.938750612437, 6146.139540464249, 6226.128342032029, 6280.905786413116, 6330.208723909512, 5010.799568017239, 6125.418085281891, 6176.4441200292185, 6267.874642507033, 6401.263854656588, 6586.5389422739945, 6588.538802283794, 6633.1045308882685, 6657.3009833966735, 6692.866142677217, 5940.3168635605725, 5959.463648271676, 6017.699115044318, 6040.546958978006, 6043.546733995056, 6100.206973093469, 6222.62664240147, 6275.560710750204, 6277.089821975696, 6311.211098612674], "unit": "score", "name": "mootools.html", "value": 4155.988479050623}, {"lowerIsBetter": false, "replicates": [299.5581517262038, 304.7546724886467, 309.18221304649205, 316.357793678832, 317.59506629047974, 5135.178371460567, 5266.34170728659, 5300.072487314719, 5340.599455040868, 5382.6232163748555, 5229.111051121309, 5277.575054735219, 5289.788408463666, 5291.074062039147, 5300.443453437391, 3849.2301539692176, 3912.823922923461, 4017.236725022251, 4076.347784354504, 4083.1425400665894, 4018.095928416112, 4025.8389664413535, 4029.516458025041, 4031.717779755418, 4034.435179074917, 3984.4222587724907, 3984.9203015939665, 3986.820593073319, 3990.38149086892, 3990.4413382126527, 3807.667316439252, 3886.805659717031, 3956.9802150989062, 3982.9601703983026, 3987.441758153861, 3436.467347561132, 3443.276911848515, 3447.6552344765573, 3449.913752156191, 3457.2048428861253, 4999.625028122905, 5006.874828129289, 5010.849674509771, 5016.724080175589, 5024.296598476216, 4585.105904348653, 4589.609883159936, 4594.88512787183, 4596.954030459686, 4601.148787474294, 5530.004599172147, 5531.225628412026, 5532.917006244909, 5538.861528461781, 5547.057000309957, 3793.620637936212, 3801.7718936863876, 3803.2013277211818, 3803.410471376941, 3806.200697853454, 5684.8010319638615, 5783.074708046693, 5810.941890581083, 5844.327902291248, 5860.70696465175, 3917.804109794499, 3928.5071672764166, 3929.174873276587, 3933.252681990413, 3935.5080614923136, 3985.621365970286, 3990.1221731219084, 3992.261431635157, 3994.08136128692, 3995.340768773178, 4584.266517357207, 4588.0, 4589.357489951342, 4593.747343896051, 4595.448546174481, 5545.390007099216, 5558.972205138948, 5560.138178582326, 5571.470710282517, 5572.498475137257, 1368.1244003837553, 1391.596437033249, 1393.6724869655623, 1395.818543589327, 1396.1134679478605, 855.2003876375609, 883.4037025008093, 914.1726737302752, 933.7992331648728, 936.8547875079373, 4792.808287668524, 4825.5898248648555, 4844.442889067732, 4859.805607775649, 4875.878103047452, 5745.080787074048, 5810.709464526757, 5818.127280907897, 5826.504747096545, 5833.504152147115, 4925.359703238628, 4932.062908047531, 4934.210526315772, 4941.555260026615, 4942.5304596063315, 3075.0, 3110.751139908802, 3111.0822307419367, 3115.5638210650527, 3116.298832762656, 5468.398476167618, 5523.530499907472, 5524.861878453071, 5526.364468086141, 5532.917006244909, 5797.894161082963, 5863.560232982543, 5922.733476993546, 5956.434138756811, 5962.522998160223, 5468.890622187613, 5499.450054994549, 5513.5037846594, 5517.4482551745305, 5518.144687573433, 5783.190353350618, 5786.768529258782, 5788.623739456922, 5796.536277097738, 5798.913016304675, 5680.801171958961, 5693.715314234355, 5696.287964004499, 5697.914531282117, 5698.059820129798, 5507.779688812403, 5509.3664228612615, 5512.5314348280845, 5518.91721624184, 5523.8066667666435, 3890.1052757866414, 3992.7005474590105, 4024.396340548941, 4033.4151548024784, 4037.798110094425, 5701.287339082614, 5723.942760572341, 5724.79963201286, 5730.255066841451, 5731.8567035824435, 5517.089680202882, 5522.723863806713, 5525.944740552543, 5526.751296191762, 5528.336599608073, 5522.806701765419, 5526.50261476469, 5526.91709624364, 5527.585431092603, 5536.806211782568, 5453.26380938584, 5457.890842183055, 5460.5904557159165, 5476.58925580591, 5481.506664400223, 5417.51242388187, 5559.416261292506, 5584.246126772834, 5586.385497595343, 5587.832365029056, 5412.810551630674, 5445.59158063139, 5456.890862182813, 5457.863553411196, 5458.099413596871], "unit": "score", "name": "prototype.html", "value": 4145.869122667452}, {"lowerIsBetter": false, "replicates": [711.8256027273319, 729.6096588325244, 758.27963434737, 777.4557809533328, 783.6081959020489, 12340.753184936297, 12456.688582785435, 12501.374931253424, 12507.499700012, 12535.310557919322, 12153.088518361114, 12154.69613259669, 12159.635210943663, 12244.326562039107, 12255.448504817283, 636.5575924732312, 789.2541548236918, 795.5266616363255, 800.0239707556772, 801.6352559585404, 800.9359251259914, 804.3565147881701, 808.0182578167526, 810.9837803243931, 812.0823469479479, 668.7692746002622, 835.1648351648352, 850.0734199722301, 850.9021462531795, 852.424613385962, 829.854775414303, 847.5507980770202, 848.3425345357335, 848.8472075026493, 848.944818586793, 619.6468013232459, 620.1534904854841, 620.4571000374672, 622.6015350175891, 622.785139127005, 12232.755344893141, 12263.509459621604, 12272.754544909141, 12301.630951071482, 12309.69225769354, 11456.083513318914, 12054.15620906528, 12060.276383417024, 12160.331181784999, 12207.938960305142, 9901.306908516406, 9944.95027524865, 9968.601255949754, 10034.59861605535, 10169.186465082776, 3306.504024396336, 3317.8296112818243, 3344.7491438142238, 3382.3573521030926, 3420.863165473378, 41871.79064104691, 42155.57844421578, 42253.0, 42390.57609423928, 42526.14947701059, 9570.521473926276, 9864.753381165385, 9938.354006989523, 10192.643257485952, 10193.0, 16988.74516882248, 17008.0, 17029.744553831704, 17224.933008039116, 17236.138193090545, 6759.831004224835, 6939.20199177091, 6957.756478523227, 7071.04540886984, 7100.573965562083, 3515.261795023074, 3597.478365636968, 3820.102275965146, 3829.100161462054, 3897.863574774926, 2799.566067259578, 2886.8845246190335, 2902.4485347784275, 2905.7239562241552, 2925.283305590144, 497.93526841510374, 509.30988510568386, 530.2232229783309, 557.8744782423922, 561.1386521689187, 561.9098948040869, 606.5905513778182, 633.8732253549308, 642.1138828416848, 643.5623775832479, 7469.51448155879, 7668.118166410823, 7801.180876008051, 7869.763907082796, 8011.799705007422, 511.6316252298339, 529.7430746088144, 539.6842846934587, 605.3673910763263, 606.7652327513489, 3625.274945011008, 3731.6641502264924, 3756.7558108722847, 3812.783689262583, 3837.213371258885, 47557.762211188725, 48571.0, 49207.0, 49219.50780492221, 49500.0, 39372.60627393689, 39508.0, 39843.60156398457, 39940.0, 40347.59652403439, 35930.820345898625, 36108.277834443164, 36369.81815090908, 36511.81744091315, 36617.0, 7990.647778847687, 8013.398995075276, 8099.14958929304, 8203.097659257357, 8221.79445513867, 31325.216869578442, 31723.365532688757, 32065.67934320627, 32504.512432314008, 32926.506102408006, 36876.63123368839, 37843.243135136596, 39803.80098099491, 39882.0, 40098.39852402275, 10248.846267305848, 10378.896211037792, 10403.58385664565, 10434.217433692655, 10436.217283703601, 10915.617953371593, 11341.886581134084, 11347.773044539228, 11399.0, 11535.36555489456, 8160.240301554883, 10592.629257975934, 10688.679339619825, 11106.222564420414, 11119.72200694989, 10964.835527466936, 11040.558377664804, 11042.834357484804, 11060.612878549213, 11103.666889993314, 10622.628208012682, 10817.080548153495, 10825.945870270598, 10834.729131771768, 11038.944805275922, 9107.041985973048, 9118.498482583522, 9436.858447123435, 9495.0, 9531.475768832503, 8973.05782892787, 9098.863517047117, 9126.0, 9154.0, 9173.312001599774], "unit": "score", "name": "yui.html", "value": 5835.805559933937}], "name": "dromaeo_css", "value": 6304.494883632627}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 113.0, 113.0, 100.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 155.0, 184.0, 133.0, 160.0, 163.0, 133.0, 178.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 109.0, 108.0, 74.0, 74.0, 75.0, 116.0, 100.0, 78.0], "unit": "score", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 146.0, 93.0, 94.0, 95.0, 144.0, 96.0, 94.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 66.0, 64.0, 65.0, 66.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 83.0, 83.0, 82.0, 81.0, 81.0, 82.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 126.0, 124.0, 121.0, 125.0, 142.0, 121.0, 128.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 139.0, 139.0, 139.0, 131.0, 141.0, 140.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1526.9}]} 04:33:05 INFO - Return code: 0 04:33:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:33:05 ERROR - # TBPL SUCCESS # 04:33:05 INFO - Running post-action listener: _resource_record_post_action 04:33:05 INFO - Running post-run listener: _resource_record_post_run 04:33:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524599296; Read time: 12; Write time: 469524 04:33:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 240050176; Read time: 0; Write time: 275660 04:33:06 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284549120; Read time: 12; Write time: 193864 04:33:06 INFO - Running post-run listener: _upload_blobber_files 04:33:06 INFO - Blob upload gear active. 04:33:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:06 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:33:06 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:33:06 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:33:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:07 INFO - (blobuploader) - INFO - Done attempting. 04:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:08 INFO - (blobuploader) - INFO - Done attempting. 04:33:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:08 INFO - Return code: 0 04:33:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd3f88d1c6206927f5b3e176feabdc4f6d06f0bfd007a3d381d4f4f20ea071275d61530a6c973890fa906b6dbe482c74ee7214c2950161e9f0a17d890865037a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3cd086cafcd4a5ee8af2d6448731d12e01183c57b0f8bbc7011763665361400541e81afa0163f7c9a444dd1889e5471f91773e9fe7e48dd2ee165294ebd85c"} 04:33:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:08 INFO - Contents: 04:33:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd3f88d1c6206927f5b3e176feabdc4f6d06f0bfd007a3d381d4f4f20ea071275d61530a6c973890fa906b6dbe482c74ee7214c2950161e9f0a17d890865037a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3cd086cafcd4a5ee8af2d6448731d12e01183c57b0f8bbc7011763665361400541e81afa0163f7c9a444dd1889e5471f91773e9fe7e48dd2ee165294ebd85c"} 04:33:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:08 INFO - Copying logs to upload dir... 04:33:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.955482 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-05 04:33:08.186729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 04:33:08.190603) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd3f88d1c6206927f5b3e176feabdc4f6d06f0bfd007a3d381d4f4f20ea071275d61530a6c973890fa906b6dbe482c74ee7214c2950161e9f0a17d890865037a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3cd086cafcd4a5ee8af2d6448731d12e01183c57b0f8bbc7011763665361400541e81afa0163f7c9a444dd1889e5471f91773e9fe7e48dd2ee165294ebd85c"} build_url:https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/d2eWxNflSGy2O4N5R5sMPQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd3f88d1c6206927f5b3e176feabdc4f6d06f0bfd007a3d381d4f4f20ea071275d61530a6c973890fa906b6dbe482c74ee7214c2950161e9f0a17d890865037a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e3cd086cafcd4a5ee8af2d6448731d12e01183c57b0f8bbc7011763665361400541e81afa0163f7c9a444dd1889e5471f91773e9fe7e48dd2ee165294ebd85c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 04:33:08.214775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:33:08.215072) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1459854755.703466-1033982133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 04:33:08.300765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 04:33:08.301716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 04:33:08.302741) ========= ========= Total master_lag: 0.28 =========