builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1456836718.5 results: success (0) buildid: 20160301035440 builduid: 5e85e88376174906985f69bb8a085699 revision: bb1dbd40af536693f138bcfd4111760aef17723f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.501138) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.501674) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.502003) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004311 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.522694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.523036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.542555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.542964) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.592804) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.593219) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.593656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.593973) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 04:51:59-- 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% 40.2M=0s 2016-03-01 04:51:59 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182602 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.790972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.791750) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:58.844956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 04:51:58.845666) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb1dbd40af536693f138bcfd4111760aef17723f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bb1dbd40af536693f138bcfd4111760aef17723f --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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 04:51:59,537 truncating revision to first 12 chars 2016-03-01 04:51:59,537 Setting DEBUG logging. 2016-03-01 04:51:59,537 attempt 1/10 2016-03-01 04:51:59,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb1dbd40af53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 04:52:00,494 unpacking tar archive at: mozilla-central-bb1dbd40af53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.646073 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 04:52:00.504747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:52:00.505123) ========= echo bb1dbd40af536693f138bcfd4111760aef17723f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bb1dbd40af536693f138bcfd4111760aef17723f'] 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bb1dbd40af536693f138bcfd4111760aef17723f program finished with exit code 0 elapsedTime=0.003452 script_repo_revision: 'bb1dbd40af536693f138bcfd4111760aef17723f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:52:00.553538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:52:00.553916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:52:00.564130) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-01 04:52:00.564584) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:01 INFO - MultiFileLogger online at 20160301 04:52:01 in /builds/slave/test 04:52:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:52:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:01 INFO - {'append_to_log': False, 04:52:01 INFO - 'base_work_dir': '/builds/slave/test', 04:52:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:52:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:01 INFO - 'branch': 'Firefox-Non-PGO', 04:52:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:01 INFO - 'config_files': ('talos/linux_config.py',), 04:52:01 INFO - 'default_actions': ('clobber', 04:52:01 INFO - 'read-buildbot-config', 04:52:01 INFO - 'download-and-extract', 04:52:01 INFO - 'populate-webroot', 04:52:01 INFO - 'create-virtualenv', 04:52:01 INFO - 'install', 04:52:01 INFO - 'run-tests'), 04:52:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:01 INFO - 'download_minidump_stackwalk': True, 04:52:01 INFO - 'download_symbols': 'ondemand', 04:52:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:01 INFO - 'installer_path': 'installer.exe', 04:52:01 INFO - 'log_level': 'info', 04:52:01 INFO - 'log_name': 'talos', 04:52:01 INFO - 'log_to_console': True, 04:52:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:01 INFO - 'opt_config_files': (), 04:52:01 INFO - 'pip_index': False, 04:52:01 INFO - 'sps_profile': False, 04:52:01 INFO - 'sps_profile_interval': 0, 04:52:01 INFO - 'suite': 'dromaeojs', 04:52:01 INFO - 'system_bits': '32', 04:52:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:01 INFO - 'title': 'talos-linux64-ix-021', 04:52:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:01 INFO - 'use_talos_json': True, 04:52:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:01 INFO - 'work_dir': 'build'} 04:52:01 INFO - ##### 04:52:01 INFO - ##### Running clobber step. 04:52:01 INFO - ##### 04:52:01 INFO - Running pre-action listener: _resource_record_pre_action 04:52:01 INFO - Running main action method: clobber 04:52:01 INFO - rmtree: /builds/slave/test/build 04:52:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:01 INFO - Running post-action listener: _resource_record_post_action 04:52:01 INFO - ##### 04:52:01 INFO - ##### Running read-buildbot-config step. 04:52:01 INFO - ##### 04:52:01 INFO - Running pre-action listener: _resource_record_pre_action 04:52:01 INFO - Running main action method: read_buildbot_config 04:52:01 INFO - Using buildbot properties: 04:52:01 INFO - { 04:52:01 INFO - "project": "", 04:52:01 INFO - "product": "firefox", 04:52:01 INFO - "script_repo_revision": "production", 04:52:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:52:01 INFO - "repository": "", 04:52:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:52:01 INFO - "buildid": "20160301035440", 04:52:01 INFO - "pgo_build": "False", 04:52:01 INFO - "basedir": "/builds/slave/test", 04:52:01 INFO - "buildnumber": 5, 04:52:01 INFO - "slavename": "talos-linux64-ix-021", 04:52:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:52:01 INFO - "platform": "ubuntu64_hw", 04:52:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:52:01 INFO - "branch": "mozilla-central", 04:52:01 INFO - "repo_path": "mozilla-central", 04:52:01 INFO - "revision": "bb1dbd40af536693f138bcfd4111760aef17723f", 04:52:01 INFO - "stage_platform": "linux64", 04:52:01 INFO - "builduid": "5e85e88376174906985f69bb8a085699", 04:52:01 INFO - "slavebuilddir": "test" 04:52:01 INFO - } 04:52:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:52:01 INFO - Running post-action listener: _resource_record_post_action 04:52:01 INFO - ##### 04:52:01 INFO - ##### Running download-and-extract step. 04:52:01 INFO - ##### 04:52:01 INFO - Running pre-action listener: _resource_record_pre_action 04:52:01 INFO - Running main action method: download_and_extract 04:52:01 INFO - mkdir: /builds/slave/test/build/tests 04:52: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:52:01 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:52:02 INFO - Downloaded 1448 bytes. 04:52:02 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:52:02 INFO - Using the following test package requirements: 04:52:02 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:52:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:52:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'jsshell-linux-x86_64.zip'], 04:52:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:52:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:52:02 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:52:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:52:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:52:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:52:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:52:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:02 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:04 INFO - Downloaded 22077416 bytes. 04:52:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:52:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:52:05 INFO - Return code: 0 04:52:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:52: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:52:05 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:52:06 INFO - Downloaded 22077416 bytes. 04:52:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:52:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:52:07 INFO - Return code: 0 04:52:07 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:52:07 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:52:09 INFO - Downloaded 10713413 bytes. 04:52:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:52:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:52:09 INFO - Return code: 0 04:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:09 INFO - https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:52:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:52:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:52:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:52:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:52:11 INFO - Downloaded 54836349 bytes. 04:52:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:52:11 INFO - mkdir: /builds/slave/test/properties 04:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:11 INFO - Contents: 04:52:11 INFO - build_url:https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:52:12 INFO - Running post-action listener: _resource_record_post_action 04:52:12 INFO - Running post-action listener: set_extra_try_arguments 04:52:12 INFO - ##### 04:52:12 INFO - ##### Running populate-webroot step. 04:52:12 INFO - ##### 04:52:12 INFO - Running pre-action listener: _resource_record_pre_action 04:52:12 INFO - Running main action method: populate_webroot 04:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:12 INFO - '--tppagecycles', 04:52:12 INFO - '7'], 04:52:12 INFO - 'tests': ['tsvgm']}}, 04:52:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:52:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:52:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'tests': ['damp', 'tps']}, 04:52:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['damp', 'tps']}, 04:52:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:12 INFO - 'other': {'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'other_l64': {'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:52:12 INFO - 'ts_paint', 04:52:12 INFO - 'tpaint', 04:52:12 INFO - 'sessionrestore', 04:52:12 INFO - 'sessionrestore_no_auto_restore']}, 04:52:12 INFO - 'svgr': {'tests': ['tsvgx', 04:52:12 INFO - 'tsvgr_opacity', 04:52:12 INFO - 'tart', 04:52:12 INFO - 'tscrollx', 04:52:12 INFO - 'cart']}, 04:52:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['tsvgx', 04:52:12 INFO - 'tsvgr_opacity', 04:52:12 INFO - 'tart', 04:52:12 INFO - 'tscrollx', 04:52:12 INFO - 'cart']}, 04:52:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'tests': ['tp5o']}, 04:52:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'talos_options': ['--e10s'], 04:52:12 INFO - 'tests': ['tp5o']}, 04:52:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'talos_options': ['--xperf_path', 04:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:12 INFO - 'tests': ['tp5n']}, 04:52:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:12 INFO - 'talos_options': ['--e10s', 04:52:12 INFO - '--xperf_path', 04:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:12 INFO - 'tests': ['tp5n']}}, 04:52:12 INFO - 'talos.zip': {'path': '', 04:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:12 INFO - Running post-action listener: _resource_record_post_action 04:52:12 INFO - ##### 04:52:12 INFO - ##### Running create-virtualenv step. 04:52:12 INFO - ##### 04:52:12 INFO - Running pre-action listener: _resource_record_pre_action 04:52:12 INFO - Running main action method: create_virtualenv 04:52:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:12 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:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:12 INFO - Using real prefix '/usr' 04:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:15 INFO - Installing pip.................done. 04:52:15 INFO - Return code: 0 04:52:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:15 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:15 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:52:15 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:52:15 INFO - Using env: {'DISPLAY': ':0', 04:52:15 INFO - 'HOME': '/home/cltbld', 04:52:15 INFO - 'LANG': 'en_US.UTF-8', 04:52:15 INFO - 'LANGUAGE': 'en_US:en', 04:52:15 INFO - 'LOGNAME': 'cltbld', 04:52:15 INFO - 'MAIL': '/var/mail/cltbld', 04:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:15 INFO - 'MOZ_NO_REMOTE': '1', 04:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:15 INFO - 'NO_EM_RESTART': '1', 04:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:15 INFO - 'PWD': '/builds/slave/test', 04:52:15 INFO - 'SHELL': '/bin/bash', 04:52:15 INFO - 'SHLVL': '1', 04:52:15 INFO - 'TERM': 'linux', 04:52:15 INFO - 'TMOUT': '86400', 04:52:15 INFO - 'USER': 'cltbld', 04:52:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:15 INFO - '_': '/tools/buildbot/bin/python'} 04:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:15 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:52:15 INFO - Cleaning up... 04:52:15 INFO - Return code: 0 04:52:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:15 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:15 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:52:15 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:52:15 INFO - Using env: {'DISPLAY': ':0', 04:52:15 INFO - 'HOME': '/home/cltbld', 04:52:15 INFO - 'LANG': 'en_US.UTF-8', 04:52:15 INFO - 'LANGUAGE': 'en_US:en', 04:52:15 INFO - 'LOGNAME': 'cltbld', 04:52:15 INFO - 'MAIL': '/var/mail/cltbld', 04:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:15 INFO - 'MOZ_NO_REMOTE': '1', 04:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:15 INFO - 'NO_EM_RESTART': '1', 04:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:15 INFO - 'PWD': '/builds/slave/test', 04:52:15 INFO - 'SHELL': '/bin/bash', 04:52:15 INFO - 'SHLVL': '1', 04:52:15 INFO - 'TERM': 'linux', 04:52:15 INFO - 'TMOUT': '86400', 04:52:15 INFO - 'USER': 'cltbld', 04:52:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:15 INFO - '_': '/tools/buildbot/bin/python'} 04:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:15 INFO - Downloading/unpacking psutil>=0.7.1 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:17 INFO - Installing collected packages: psutil 04:52:17 INFO - Running setup.py install for psutil 04:52:17 INFO - building 'psutil._psutil_linux' extension 04:52:17 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:52:17 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:52:17 INFO - building 'psutil._psutil_posix' extension 04:52:17 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:52:17 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:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:17 INFO - Successfully installed psutil 04:52:17 INFO - Cleaning up... 04:52:18 INFO - Return code: 0 04:52:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:52:18 INFO - Using env: {'DISPLAY': ':0', 04:52:18 INFO - 'HOME': '/home/cltbld', 04:52:18 INFO - 'LANG': 'en_US.UTF-8', 04:52:18 INFO - 'LANGUAGE': 'en_US:en', 04:52:18 INFO - 'LOGNAME': 'cltbld', 04:52:18 INFO - 'MAIL': '/var/mail/cltbld', 04:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:18 INFO - 'MOZ_NO_REMOTE': '1', 04:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:18 INFO - 'NO_EM_RESTART': '1', 04:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:18 INFO - 'PWD': '/builds/slave/test', 04:52:18 INFO - 'SHELL': '/bin/bash', 04:52:18 INFO - 'SHLVL': '1', 04:52:18 INFO - 'TERM': 'linux', 04:52:18 INFO - 'TMOUT': '86400', 04:52:18 INFO - 'USER': 'cltbld', 04:52:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:18 INFO - '_': '/tools/buildbot/bin/python'} 04:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:20 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:52:20 INFO - Installing collected packages: mozsystemmonitor 04:52:20 INFO - Running setup.py install for mozsystemmonitor 04:52:20 INFO - Successfully installed mozsystemmonitor 04:52:20 INFO - Cleaning up... 04:52:20 INFO - Return code: 0 04:52:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:20 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:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:20 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:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:20 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:20 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:52:20 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:52:20 INFO - Using env: {'DISPLAY': ':0', 04:52:20 INFO - 'HOME': '/home/cltbld', 04:52:20 INFO - 'LANG': 'en_US.UTF-8', 04:52:20 INFO - 'LANGUAGE': 'en_US:en', 04:52:20 INFO - 'LOGNAME': 'cltbld', 04:52:20 INFO - 'MAIL': '/var/mail/cltbld', 04:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:20 INFO - 'MOZ_NO_REMOTE': '1', 04:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:20 INFO - 'NO_EM_RESTART': '1', 04:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:20 INFO - 'PWD': '/builds/slave/test', 04:52:20 INFO - 'SHELL': '/bin/bash', 04:52:20 INFO - 'SHLVL': '1', 04:52:20 INFO - 'TERM': 'linux', 04:52:20 INFO - 'TMOUT': '86400', 04:52:20 INFO - 'USER': 'cltbld', 04:52:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:20 INFO - '_': '/tools/buildbot/bin/python'} 04:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:20 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:22 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:22 INFO - Downloading docopt-0.6.1.tar.gz 04:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:23 INFO - Running setup.py install for blobuploader 04:52:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:23 INFO - Running setup.py install for requests 04:52:23 INFO - Running setup.py install for docopt 04:52:23 INFO - Successfully installed blobuploader requests docopt 04:52:23 INFO - Cleaning up... 04:52:23 INFO - Return code: 0 04:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:23 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:23 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:52:23 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:52:23 INFO - Using env: {'DISPLAY': ':0', 04:52:23 INFO - 'HOME': '/home/cltbld', 04:52:23 INFO - 'LANG': 'en_US.UTF-8', 04:52:23 INFO - 'LANGUAGE': 'en_US:en', 04:52:23 INFO - 'LOGNAME': 'cltbld', 04:52:23 INFO - 'MAIL': '/var/mail/cltbld', 04:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:23 INFO - 'MOZ_NO_REMOTE': '1', 04:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:23 INFO - 'NO_EM_RESTART': '1', 04:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:23 INFO - 'PWD': '/builds/slave/test', 04:52:23 INFO - 'SHELL': '/bin/bash', 04:52:23 INFO - 'SHLVL': '1', 04:52:23 INFO - 'TERM': 'linux', 04:52:23 INFO - 'TMOUT': '86400', 04:52:23 INFO - 'USER': 'cltbld', 04:52:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:23 INFO - '_': '/tools/buildbot/bin/python'} 04:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:23 INFO - Running setup.py (path:/tmp/pip-UDK3Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:23 INFO - Running setup.py (path:/tmp/pip-apP93U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:23 INFO - Running setup.py (path:/tmp/pip-bBEZd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:24 INFO - Running setup.py (path:/tmp/pip-WmFTPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:24 INFO - Running setup.py (path:/tmp/pip-waOq_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:24 INFO - Running setup.py (path:/tmp/pip-5Y6R9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:24 INFO - Running setup.py (path:/tmp/pip-z37toU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:24 INFO - Running setup.py (path:/tmp/pip-thDnFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:24 INFO - Running setup.py (path:/tmp/pip-ZVjS6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:24 INFO - Running setup.py (path:/tmp/pip-C_p3Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:24 INFO - Running setup.py (path:/tmp/pip-1rpvJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:24 INFO - Running setup.py (path:/tmp/pip-CjYr3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:24 INFO - Running setup.py (path:/tmp/pip-Q8Twrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:24 INFO - Running setup.py (path:/tmp/pip-WMonde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:24 INFO - Running setup.py (path:/tmp/pip-RLPQSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:24 INFO - Running setup.py (path:/tmp/pip-KtOqgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:24 INFO - Running setup.py (path:/tmp/pip-qXZrM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:25 INFO - Running setup.py install for manifestparser 04:52:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Running setup.py install for mozcrash 04:52:25 INFO - Running setup.py install for mozdebug 04:52:25 INFO - Running setup.py install for mozdevice 04:52:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Running setup.py install for mozfile 04:52:25 INFO - Running setup.py install for mozhttpd 04:52:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Running setup.py install for mozinfo 04:52:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Running setup.py install for mozInstall 04:52:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:25 INFO - Running setup.py install for mozleak 04:52:25 INFO - Running setup.py install for mozlog 04:52:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Running setup.py install for moznetwork 04:52:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Running setup.py install for mozprocess 04:52:26 INFO - Running setup.py install for mozprofile 04:52:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Running setup.py install for mozrunner 04:52:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Running setup.py install for mozscreenshot 04:52:26 INFO - Running setup.py install for moztest 04:52:26 INFO - Running setup.py install for mozversion 04:52:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:26 INFO - Cleaning up... 04:52:26 INFO - Return code: 0 04:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:26 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:26 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:52:26 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:52:26 INFO - Using env: {'DISPLAY': ':0', 04:52:26 INFO - 'HOME': '/home/cltbld', 04:52:26 INFO - 'LANG': 'en_US.UTF-8', 04:52:26 INFO - 'LANGUAGE': 'en_US:en', 04:52:26 INFO - 'LOGNAME': 'cltbld', 04:52:26 INFO - 'MAIL': '/var/mail/cltbld', 04:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:26 INFO - 'MOZ_NO_REMOTE': '1', 04:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:26 INFO - 'NO_EM_RESTART': '1', 04:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:26 INFO - 'PWD': '/builds/slave/test', 04:52:26 INFO - 'SHELL': '/bin/bash', 04:52:26 INFO - 'SHLVL': '1', 04:52:26 INFO - 'TERM': 'linux', 04:52:26 INFO - 'TMOUT': '86400', 04:52:26 INFO - 'USER': 'cltbld', 04:52:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:26 INFO - '_': '/tools/buildbot/bin/python'} 04:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:27 INFO - Running setup.py (path:/tmp/pip-nYUCKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:27 INFO - Running setup.py (path:/tmp/pip-3jowPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:27 INFO - Running setup.py (path:/tmp/pip-MNLWSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:27 INFO - Running setup.py (path:/tmp/pip-pl4Tws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:27 INFO - Running setup.py (path:/tmp/pip-dbB4tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:27 INFO - Running setup.py (path:/tmp/pip-xfB6R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:27 INFO - Running setup.py (path:/tmp/pip-gHMAsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:27 INFO - Running setup.py (path:/tmp/pip-vnHbQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:27 INFO - Running setup.py (path:/tmp/pip-Ru2eLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:27 INFO - Running setup.py (path:/tmp/pip-ZXTpQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:27 INFO - Running setup.py (path:/tmp/pip-qXi_DO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:27 INFO - Running setup.py (path:/tmp/pip-foKfw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:27 INFO - Running setup.py (path:/tmp/pip-MzPPGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:28 INFO - Running setup.py (path:/tmp/pip-j5Qz6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:28 INFO - Running setup.py (path:/tmp/pip-HGIZ2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:28 INFO - Running setup.py (path:/tmp/pip-FiljwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:28 INFO - Running setup.py (path:/tmp/pip-A7gIUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:28 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:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:52:28 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:52:28 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:52:28 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:52:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:30 INFO - Downloading blessings-1.6.tar.gz 04:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:52:30 INFO - Installing collected packages: blessings 04:52:30 INFO - Running setup.py install for blessings 04:52:30 INFO - Successfully installed blessings 04:52:30 INFO - Cleaning up... 04:52:30 INFO - Return code: 0 04:52:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:52:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:30 INFO - Reading from file tmpfile_stdout 04:52:30 INFO - Current package versions: 04:52:30 INFO - argparse == 1.2.1 04:52:30 INFO - blessings == 1.6 04:52:30 INFO - blobuploader == 1.2.4 04:52:30 INFO - docopt == 0.6.1 04:52:30 INFO - manifestparser == 1.1 04:52:30 INFO - mozInstall == 1.12 04:52:30 INFO - mozcrash == 0.16 04:52:30 INFO - mozdebug == 0.1 04:52:30 INFO - mozdevice == 0.48 04:52:30 INFO - mozfile == 1.2 04:52:30 INFO - mozhttpd == 0.7 04:52:30 INFO - mozinfo == 0.9 04:52:30 INFO - mozleak == 0.1 04:52:30 INFO - mozlog == 3.1 04:52:30 INFO - moznetwork == 0.27 04:52:30 INFO - mozprocess == 0.22 04:52:30 INFO - mozprofile == 0.28 04:52:30 INFO - mozrunner == 6.11 04:52:30 INFO - mozscreenshot == 0.1 04:52:30 INFO - mozsystemmonitor == 0.0 04:52:30 INFO - moztest == 0.7 04:52:30 INFO - mozversion == 1.4 04:52:30 INFO - psutil == 3.1.1 04:52:30 INFO - requests == 1.2.3 04:52:30 INFO - wsgiref == 0.1.2 04:52:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:30 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:52:30 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:52:30 INFO - Using env: {'DISPLAY': ':0', 04:52:30 INFO - 'HOME': '/home/cltbld', 04:52:30 INFO - 'LANG': 'en_US.UTF-8', 04:52:30 INFO - 'LANGUAGE': 'en_US:en', 04:52:30 INFO - 'LOGNAME': 'cltbld', 04:52:30 INFO - 'MAIL': '/var/mail/cltbld', 04:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:30 INFO - 'MOZ_NO_REMOTE': '1', 04:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:30 INFO - 'NO_EM_RESTART': '1', 04:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:30 INFO - 'PWD': '/builds/slave/test', 04:52:30 INFO - 'SHELL': '/bin/bash', 04:52:30 INFO - 'SHLVL': '1', 04:52:30 INFO - 'TERM': 'linux', 04:52:30 INFO - 'TMOUT': '86400', 04:52:30 INFO - 'USER': 'cltbld', 04:52:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:30 INFO - '_': '/tools/buildbot/bin/python'} 04:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 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:52:30 INFO - Cleaning up... 04:52:30 INFO - Return code: 0 04:52:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:30 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:30 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:52:30 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:52:30 INFO - Using env: {'DISPLAY': ':0', 04:52:30 INFO - 'HOME': '/home/cltbld', 04:52:30 INFO - 'LANG': 'en_US.UTF-8', 04:52:30 INFO - 'LANGUAGE': 'en_US:en', 04:52:30 INFO - 'LOGNAME': 'cltbld', 04:52:30 INFO - 'MAIL': '/var/mail/cltbld', 04:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:30 INFO - 'MOZ_NO_REMOTE': '1', 04:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:30 INFO - 'NO_EM_RESTART': '1', 04:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:30 INFO - 'PWD': '/builds/slave/test', 04:52:30 INFO - 'SHELL': '/bin/bash', 04:52:30 INFO - 'SHLVL': '1', 04:52:30 INFO - 'TERM': 'linux', 04:52:30 INFO - 'TMOUT': '86400', 04:52:30 INFO - 'USER': 'cltbld', 04:52:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:30 INFO - '_': '/tools/buildbot/bin/python'} 04:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:31 INFO - Downloading/unpacking jsonschema 04:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:32 INFO - Downloading/unpacking functools32 (from jsonschema) 04:52:32 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:52:32 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:52:32 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:52:32 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:52:32 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:52:32 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:52:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:33 INFO - warning: no files found matching '*.txt' 04:52:33 INFO - no previously-included directories found matching 'build' 04:52:33 INFO - no previously-included directories found matching 'dist' 04:52:33 INFO - no previously-included directories found matching '.git*' 04:52:33 INFO - Installing collected packages: jsonschema, functools32 04:52:33 INFO - Running setup.py install for functools32 04:52:33 INFO - warning: no files found matching '*.txt' 04:52:33 INFO - no previously-included directories found matching 'build' 04:52:33 INFO - no previously-included directories found matching 'dist' 04:52:33 INFO - no previously-included directories found matching '.git*' 04:52:33 INFO - Successfully installed jsonschema functools32 04:52:33 INFO - Cleaning up... 04:52:33 INFO - Return code: 0 04:52:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:33 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 0x7f59fe9c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23623b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, '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': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', '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:52:33 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:52:33 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:52:33 INFO - Using env: {'DISPLAY': ':0', 04:52:33 INFO - 'HOME': '/home/cltbld', 04:52:33 INFO - 'LANG': 'en_US.UTF-8', 04:52:33 INFO - 'LANGUAGE': 'en_US:en', 04:52:33 INFO - 'LOGNAME': 'cltbld', 04:52:33 INFO - 'MAIL': '/var/mail/cltbld', 04:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:33 INFO - 'MOZ_NO_REMOTE': '1', 04:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:33 INFO - 'NO_EM_RESTART': '1', 04:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:33 INFO - 'PWD': '/builds/slave/test', 04:52:33 INFO - 'SHELL': '/bin/bash', 04:52:33 INFO - 'SHLVL': '1', 04:52:33 INFO - 'TERM': 'linux', 04:52:33 INFO - 'TMOUT': '86400', 04:52:33 INFO - 'USER': 'cltbld', 04:52:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:33 INFO - '_': '/tools/buildbot/bin/python'} 04:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:33 INFO - Downloading/unpacking flake8 04:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:33 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:52:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:52:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:52:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:36 INFO - no previously-included directories found matching 'docs/_build' 04:52:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:52:36 INFO - Running setup.py install for pep8 04:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:52:36 INFO - no previously-included directories found matching 'docs/_build' 04:52:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:52:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:52:36 INFO - Cleaning up... 04:52:36 INFO - Return code: 0 04:52:36 INFO - Running post-action listener: _resource_record_post_action 04:52:36 INFO - Running post-action listener: _start_resource_monitoring 04:52:36 INFO - Starting resource monitoring. 04:52:36 INFO - ##### 04:52:36 INFO - ##### Running install step. 04:52:36 INFO - ##### 04:52:36 INFO - Running pre-action listener: _resource_record_pre_action 04:52:36 INFO - Running main action method: install 04:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:52:36 INFO - Reading from file tmpfile_stdout 04:52:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:52:36 INFO - Reading from file tmpfile_stdout 04:52:36 INFO - Output received: 04:52:36 INFO - Usage: mozinstall [options] installer 04:52:36 INFO - Options: 04:52:36 INFO - -h, --help show this help message and exit 04:52:36 INFO - -d DEST, --destination=DEST 04:52:36 INFO - Directory to install application into. [default: 04:52:36 INFO - "/builds/slave/test"] 04:52:36 INFO - --app=APP Application being installed. [default: firefox] 04:52:36 INFO - mkdir: /builds/slave/test/build/application 04:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:52:53 INFO - Reading from file tmpfile_stdout 04:52:53 INFO - Output received: 04:52:53 INFO - /builds/slave/test/build/application/firefox/firefox 04:52:53 INFO - Running post-action listener: _resource_record_post_action 04:52:53 INFO - ##### 04:52:53 INFO - ##### Running run-tests step. 04:52:53 INFO - ##### 04:52:53 INFO - Running pre-action listener: _resource_record_pre_action 04:52:53 INFO - Running main action method: run_tests 04:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:52:53 INFO - Python 2.7.3 04:52:53 INFO - Return code: 0 04:52:53 INFO - grabbing minidump binary from tooltool 04:52:53 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:52:53 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 0x23f1100>, '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 0x23f2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f2490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:52:53 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:52:53 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:52:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:52:53 INFO - Return code: 0 04:52:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:52:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:52:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:52:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:52:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:52:54 INFO - Return code: 0 04:52:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:52:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:52:54 INFO - Using env: {'DISPLAY': ':0', 04:52:54 INFO - 'HOME': '/home/cltbld', 04:52:54 INFO - 'LANG': 'en_US.UTF-8', 04:52:54 INFO - 'LANGUAGE': 'en_US:en', 04:52:54 INFO - 'LOGNAME': 'cltbld', 04:52:54 INFO - 'MAIL': '/var/mail/cltbld', 04:52:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:52:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:54 INFO - 'MOZ_NO_REMOTE': '1', 04:52:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:54 INFO - 'NO_EM_RESTART': '1', 04:52:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:54 INFO - 'PWD': '/builds/slave/test', 04:52:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:52:54 INFO - 'SHELL': '/bin/bash', 04:52:54 INFO - 'SHLVL': '1', 04:52:54 INFO - 'TERM': 'linux', 04:52:54 INFO - 'TMOUT': '86400', 04:52:54 INFO - 'USER': 'cltbld', 04:52:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824', 04:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:54 INFO - '_': '/tools/buildbot/bin/python'} 04:52:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:52:54 INFO - mozversion application_buildid: 20160301035440 04:52:54 INFO - mozversion application_changeset: bb1dbd40af536693f138bcfd4111760aef17723f 04:52:54 INFO - mozversion application_display_name: Nightly 04:52:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:52:54 INFO - mozversion application_name: Firefox 04:52:54 INFO - mozversion application_remotingname: firefox 04:52:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:52:54 INFO - mozversion application_vendor: Mozilla 04:52:54 INFO - mozversion application_version: 47.0a1 04:52:54 INFO - mozversion platform_buildid: 20160301035440 04:52:54 INFO - mozversion platform_changeset: bb1dbd40af536693f138bcfd4111760aef17723f 04:52:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:52:54 INFO - mozversion platform_version: 47.0a1 04:52:54 INFO - using testdate: 1456836774 04:52:54 INFO - actual date: 1456836774 04:52:54 INFO - starting webserver on 'localhost:37732' 04:52:54 INFO - SUITE-START | Running 2 tests 04:52:54 INFO - TEST-START | dromaeo_css 04:52:54 INFO - operating with platform_type : linux_ 04:52:54 INFO - Initialising browser for dromaeo_css test... 04:52:54 INFO - TEST-INFO | started process 29589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHr7Eg/profile http://localhost:37732/getInfo.html) 04:53:00 INFO - PROCESS | 29589 | __metrics Screen width/height:1600/1200 04:53:00 INFO - PROCESS | 29589 | colorDepth:24 04:53:00 INFO - PROCESS | 29589 | Browser inner width/height: 1024/697 04:53:00 INFO - PROCESS | 29589 | __metrics 04:53:01 INFO - PROCESS | 29589 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:53:01 INFO - PROCESS | 29589 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:53:02 INFO - TEST-INFO | 29589: exit 0 04:53:02 INFO - Browser initialized. 04:53:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:02 INFO - TEST-INFO | started process 29683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHr7Eg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:14 INFO - PROCESS | 29683 | RSS: Main: 153718784 04:53:14 INFO - PROCESS | 29683 | 04:54:05 INFO - PROCESS | 29683 | 1456836845770 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:56:17 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37732/tests/dromaeo/cssquery-ext.html) 04:56:18 INFO - PROCESS | 29683 | RSS: Main: 239255552 04:56:18 INFO - PROCESS | 29683 | 04:59:20 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-ext.html (next: http://localhost:37732/tests/dromaeo/cssquery-jquery.html) 04:59:21 INFO - PROCESS | 29683 | RSS: Main: 232853504 04:59:21 INFO - PROCESS | 29683 | 05:02:23 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37732/tests/dromaeo/cssquery-mootools.html) 05:02:23 INFO - PROCESS | 29683 | RSS: Main: 232525824 05:02:23 INFO - PROCESS | 29683 | 05:05:25 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37732/tests/dromaeo/cssquery-prototype.html) 05:05:26 INFO - PROCESS | 29683 | RSS: Main: 211767296 05:05:26 INFO - PROCESS | 29683 | 05:08:29 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37732/tests/dromaeo/cssquery-yui.html) 05:08:29 INFO - PROCESS | 29683 | RSS: Main: 197054464 05:08:29 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | Cycle 1(1): loaded http://localhost:37732/tests/dromaeo/cssquery-yui.html (next: http://localhost:37732/tests/dromaeo/cssquery-dojo.html) 05:11:32 INFO - PROCESS | 29683 | RSS: Main: 251285504 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | __start_tp_report 05:11:32 INFO - PROCESS | 29683 | _x_x_mozilla_page_load 05:11:32 INFO - PROCESS | 29683 | _x_x_mozilla_page_load_details 05:11:32 INFO - PROCESS | 29683 | |i|pagename|runs| 05:11:32 INFO - PROCESS | 29683 | |0;dojo.html;2603.062897356951;2666.066876593193;2671.265402014447;2673.973260267398;2696.689880663723;4326.545712700161;4411.889702757425;4426.734395936242;4441.578050085245;4450.821967121311;4447.555244475551;4483.4171557697455;4508.120916421299;4512.481064677563;4519.254323036695;4088.693347998897;4102.118044620406;4108.876733697994;4112.814923328458;4200.51694055183;4138.4413104231;4152.875413737577;4188.811503482335;4216.177845320164;4225.809838557257;4012.518497780285;4037.1723796621914;4079.5512493625974;4130.318497447917;4140.772257525835;4046.719681908549;4061.5938406159444;4066.207089617526;4095.692823038254;4107.322291821846;4066.552679205285;4068.7355321903983;4075.8777236682945;4081.4498997547503;4097.959020409788;4291.549387314319;4358.564143585616;4402.691811573191;4433.246348120827;4461.821527138911;4643.767811609406;4670.556297151765;4672.486026537078;4673.949881381945;4696.577308042259;4604.930926036079;4688.953110468886;4693.24908014716;4710.105080034782;4723.504032076651;4409.536998615131;4453.799579018952;4457.64338852891;4483.50681425043;4503.54964503547;4851.36932198819;4869.732164730903;4870.464248932614;4871.975640121776;4889.193283108319;4568.497465278817;4659.254519276899;4686.835960741358;4690.202665546865;4717.834875779331;4778.761061946889;4798.136335459581;4799.880002999953;4813.807447702123;4839.758012099381;4742.881427964328;4747.074320507468;4749.216379297446;4750.395783601925;4776.9761151194025;4587.610053145453;4642.37327960721;4727;4737.052589482118;4770.332153498513;3971.6425521703186;3989.7007724420782;3992.2215168041953;4017.0961533655277;4026;3496.1958749487762;3507.7544571879725;3511.613722490524;3529.6293889141784;3536.0629433200224;4031.717779755389;4075.633193012584;4112.609302116294;4151.813168407429;4187.602177793105;4779.641526885497;4779.856604301876;4782.450018247877;4824.469308376076;4825.9034819304115;4116.094459218967;4151.875443736692;4156.771377574262;4160.292750232467;4193.035601811601;4135.710500265012;4221.113566151082;4292;4301.935470967938;4309.41822853917;4492.573205545468;4519.593236608721;4520.095980803852;4530.546945305443;4559.065391594781;4685.882852928704;4707.129181101507;4759.643026773075;4760.381150450419;4771.832985845479;4429.269170586817;4477.462704475483;4518.209313370213;4532.138893610204;4551.3173024046655;4670.883227919193;4674.322223277673;4678.059641275746;4680.297955306732;4703.129920964632;4594.104149690778;4748.430188377417;4749.786259618257;4753.382060332273;4790.137775200497;4616.515265897033;4651.093036857916;4658.417697787777;4673.602743766682;4694.718316900997;4628.328892310664;4628.39830821991;4631.976840115778;4633.814647414066;4670.766461676971;4393.582609652078;4461.174682683714;4524.298733696282;4533.705309154894;4575.1993401153995;4633.559811817872;4665.813367465264;4675.906481870412;4709.48195698466;4714.5521175488275;4514.503404625423;4553.11214313219;4553.6357091433265;4585.770711464346;4591.517890621437 05:11:32 INFO - PROCESS | 29683 | |1;ext.html;472.1736960319439;473.1105521619355;494.3326509212563;504.90406822703704;520.7292208051813;24229.878850605743;24614;31926.52110218343;32095.35809283813;32289;33922;34310.8284458578;34428.65571344286;34477.65522344776;34522;7493.288137626931;7697.692092316301;7698.884516732253;7701.114371847253;7703.46075774696;6963.895541566881;9946.751331216741;10202.132818710419;10215.284930054899;10217.131543818785;9680.177184939288;9739.220862331033;9781.364211326276;9783.510824458785;9810.068043535888;9629.470379129145;9737.026297370241;9740.805183896353;9778.168855647278;9808.705738827846;9546.3794853335;9601.951990240004;9683.951580242054;9690.95154524223;9692.612295508172;31466.37067258642;35124.29751404983;35193.64806351929;35239.64760352415;35931.4610280846;2307.492351682627;2476.7647073527987;2675.3712877473777;2720.2519307190482;2974.7025297470295;26558.867205664043;27123.86438067817;27261.591076133675;27656.308592285353;28142.859285703442;3064.172673378175;3069.416810805962;3090.9845450772827;3105.658377578487;3161.462551366273;221907.89046054828;222476;222586;223297;223872;36456.453153202725;37113.25773484515;37145;37601.24797504034;51560.74219628878;35556.82221588876;35675.10812229715;35748.642513575054;35766.28467430637;35962.10094747652;10839.620613278497;10840.945795270973;10846.67459976202;10864.456777161111;10893.618723344645;7695.653695583712;8564.871526927102;8573.399862009725;8642.654293828176;8979;12197.69505762363;12270.447829847679;12276.508939642314;12290.631281061582;12397.62807115788;4933.333999910038;4992.975035124801;5083.771230294646;5103.591712662978;5113.71874546896;751.8421131562324;846.34408333542;895.8297923394534;942.6323733743845;986.6448078691665;24019;25813.3546661335;25829.870850646003;25950;26159.869200654255;849.5539841583218;925.6575067225169;945.4232917920064;994.7115336552318;1002.2282842211602;12927.5475358362;13485.730285394236;13501.932490337485;13548.45806167762;13632.65918352049;252315;387445;395716;396468;397599;40169.59830401717;40589.39115913264;40741;40912.181756364706;41342.37986430206;1044.4099084017505;1048.8479170520231;1092.257265059751;1112.710695219249;1127.312339472921;23916.760832391454;25324.97400207942;25601.23196304114;25721.228363149134;25787.226383208534;33176.83411582927;33888.322233554696;34076.31847362989;34226.48660270148;34324;175191;175671;178202.10898945422;181760;182500;23212.883935580216;26673;27403.725962740118;27665.308367290174;28153.296167595156;31038.22404439907;31498.37003259968;31585.84207079042;31749.523757144125;31928.84035579807;28699.713002869703;28988.27529311784;29218.123456296344;29785.404291913608;30025;29779.55330670085;29818.254543636584;29836.552451713676;30150.54774178433;30259.848700756356;29447.852760736918;30190.54714179333;30229.395412092075;33450.330993380485;34531.755435896586;26044.73955260423;26213.475730485665;27188.26162646108;28997.275068123465;29407.85296073506;22696.205632802772;22859.771402285765;23061.19285824988;23186.536269274184;23260.418489537897 05:11:32 INFO - PROCESS | 29683 | |2;jquery.html;295.7885112144816;304.70443669640457;312.6092384519351;317.93641271745656;321.7747576696313;11244.606438774645;14471.421143154274;14490.710185796277;15022.173780442085;15044.172570508632;12709.23744575326;12875.935620321909;12968.351582420888;13048.93475532621;13662.453501859914;4665.183592871251;4913.852584422473;4914.3611330527165;4940.6788558743565;4942.901141977159;3493.8602455901732;4773.928391074137;4901.877453063684;5319.122344813101;5535.446455354472;5456.454354564551;5467.480589344026;5480;5484.533814625742;5491.505764481196;5269.920951185716;5444.50999410053;5452.563794896399;5488;5496.532794712454;4826.734529600871;4827.106985207748;4828.7102773833685;4837.2260438329695;4840.394950631171;18416.815831841643;18443.815561844345;18444.90777546117;18470.16884240199;18473.538161545934;1855.313533992418;1884.4911873794;2065.5972085443345;2153.2894144932134;2345.64815277708;11734.413279335999;12132.45403956824;12143.453544590515;12366.319852408114;12539.686507837287;1620.2627804348992;1759.3930094117509;1777.4578753480184;1801.7387478815629;1832.8075552066973;48478;48613.513864861256;48645.51354486445;48819.99999999964;49065.264021039715;9110.59002344896;9119.407238529475;9192.172704456498;9270.30472714549;9273.721788346225;10744.462776861126;11568.942155289169;11665.591704290478;11686;11715.472803723853;5705.258316418839;5974.462298393166;5983.461488466059;6009.729562169713;6242.438180563771;5736.082226843685;5751.626144300607;5814.011618024946;5820.534357251409;5839.445252700986;3741.9064523386587;3748.475213470116;3764.3600587899573;3809.3904975203836;3840.884773456745;1674.7487876818575;1681.5039563328846;1704.6164612961984;1741.8519425848692;1757.393699173783;805.8186907945666;822.7326119011345;915.0666320353203;919.5678031325266;926.6061923682408;14901.329440175217;15046.247687615794;15079.698406031817;15082.472113475975;15087.547373578811;801.9599020048975;817.4604760857806;833.9583020848934;845.1675100026468;848.9617967191491;8445.366597505088;8570.314374849997;8605.741827745178;8629.654813807378;8852.424592401474;273419;274640;276759;277038;364286;57695.846083078104;64653.67673161698;65764;67415.3258467409;68786;852.1095455249404;864.2222000199745;883.0108708449387;904.7421484876778;912.8904531456135;13814.516491922734;13963.650908727363;14281.64295892611;14368.13791172533;14418.495352662607;20507.38477845667;20848.687269690665;24177.758222418255;26162.86918565395;28361.43277134487;34784.82607586946;35943.64056359507;36054.098647534025;37093.258134836615;37854.62145378621;6974.895376569254;7039.472039596948;7120.394766444911;7143.285671432815;7147.53541019832;9185.77035574116;9913.603455861685;10189.54147063369;10213.131883789962;10441.843372349269;8552.957235213784;9031.864522032043;9257.67598134062;9808.264380171373;9992.850107248252;8516.361272904433;9116.1339672731;9296.6281348748;9347.766305842408;9365.531723413938;9035.548222588975;9133.406328588886;9707.174890134418;9720.805583888425;10325.896741032793;7066.858662826818;7182.928170718435;7275.6362181889635;7277.053982982178;7297;9387.530623468936;9668.274879383933;10021.248406369697;10045.196384289386;10337.37975721459 05:11:32 INFO - PROCESS | 29683 | |3;mootools.html;1179.746354533775;1249.1505776072272;1272.236658005197;1290.509606349587;1551.7827504149427;5872.383399743024;6625.86748265035;6754.49341299402;6785.6267905265195;6794.388505034546;6747.831304217397;6895.44836413087;6914.723411063552;6919.792406227822;6926.203486599043;1708.666809972056;1758.4373000639737;1760.3750668512685;1983.821456068957;2009.7688765791902;1968.675168597187;2031.4616626593966;2032.7865574114726;2033.613613413454;2037.246218899002;1946.9902650486729;1957.4029920874127;1976.7924367941375;1976.8220860122585;1977.4166620846884;1822.662807380639;1823.0975667044831;1825.9087045647732;1827.1869018286802;1829.268292682924;1958.7649482062102;1965.105876826055;1968.9015549222481;2005.0476023888682;2015.6271089848278;6991.930080699179;7005.649717514155;7006.299370062953;7007.509474336798;7020.05229294049;3692.40921452569;3767.7362584619086;3767.830447629863;3768.773873567595;3773;2590.2223266009123;2621.9868900655374;2642.141304076183;2656.933576660599;2674.3581540430155;857.8541647919868;876.3646356391629;888.7511496780912;892.8526793079199;1617.6926383987004;8941.284697224271;9005.459672419676;9008.639654413815;9018.684346047923;9026.548672566345;3507.2985402919517;3531.752777305564;3606.693431058337;3668.284684486553;3687.870924517629;7485.176630570633;7530.548167109991;7530.849383012309;7550.886736698954;7558.055243094614;3784.7161462890394;3806.371948628501;3810.8856734298015;3815.561210460777;3815.618438156162;2963.6443626764926;3430.8456119474185;3470.1671598816606;3477.8434970426392;3519.6128425873135;2940.9852950735535;3014.8643311051055;3026.424979253935;3035.8918994566825;3036.6963303669454;865.0268447996004;873.0876234335135;883.0198479687542;883.3463237204422;889.1819526036062;983.9458829764432;993.6671215143008;1004.2417974429259;1006.074411541369;1039.4387031003173;6368.808935731936;6462.450691691259;6472.3204063573585;6483.870322593616;6494.870102597922;402.01105281009046;407.4987765048947;415.89810496428566;423.21916064860284;424.0649368143237;4864.73243971585;4896.387951506062;4922.384701912261;4927.852164435073;4991.176455884738;8149.674013039531;8247.340212782963;8347.123552027071;8374.078851326349;8396.538190399464;8252.546109964009;8336.66653333872;8361.331093512505;8364.289035432057;8410.873836892451;6478.481721462272;6525.771597994048;6598.802035938929;6623.271440141581;6680.899786503206;6128.693565321627;6142.109394137736;6149;6161.44546990773;6183.474404675653;7267.600281984542;7455.739049133254;7530.548167109991;7639.350655194148;7657.157712651492;7639.732609358646;7690.230976902265;7896.407769417202;7961.800954976172;7992.5204487730925;4913.385826771653;5349.786008559614;5510.862228444321;5604.467575580314;5639.520640745583;6298.275698294571;6381.93618063832;6382;6387.840303992437;6391.201099862517;5561.777528898799;5569.805056822992;5598.636088654224;5662.546996240373;5714.3999880012;5549.667019978814;5643.802466913638;5693.772249109989;5782.479576837936;5792.652440853562;5817.883642327045;6015.819525414245;6128.233970753656;6152.261728592597;6154.1999540059505;5501.917471237854;5558.861028474321;5572.275604171432;5574.665520068809;5585.413531579125;5653.265075540154;5739.483446489836;5743.9138412923;5750.913736293875;5751.7411716472025 05:11:32 INFO - PROCESS | 29683 | |4;prototype.html;280.5833337493822;281.7703571589155;283.54349497309335;288.3842995205236;289.77687180870714;5165.793368265275;5212.947870521293;5214.8696282592955;5215.58275337973;5237.266782650432;5094.133997220472;5172.327597412331;5174.922376164361;5176.611754118447;5182.429932707409;3798.810059497028;3912.2762288976487;3950.328444164499;3973.8807835764974;4047.7368971016936;3991.1219531702977;4031.818568164425;4052.3516237402023;4053.5743746906446;4054.0878302381875;4020.5376381716037;4020.819063142151;4025.2553277643583;4029.717919745619;4031.97984010081;3788.886333410002;3879.398693202558;3947.072437977073;3950.1902110067367;3974.7813870237123;3442.277121804424;3449.085992212066;3462.549868517102;3469.09803451102;3477.6348483409383;4893.437254715717;4976.228684553864;4979.228219625964;4985.127602669555;4992.151334273182;4558.8860278492975;4567.177907976563;4568.794404251817;4572.01701634147;4573.245414506602;5418.268533747933;5421.783128674848;5431.375391829951;5434.347878254595;5439.211314359435;3797.1076796952693;3808.7905165215902;3812.618738126193;3815.3323168445413;3815.351390263634;5461.5357694596005;5693.601447898649;5700.885982280372;5707.800226992077;5711.742971566289;3704.407294832814;3712.2204337089515;3718.2377612589353;3720.1815600567834;3720.6837418819705;3773.7924414156937;3774.2828862516035;3774.3960966245268;3776.66010059096;3777.036855601804;4408.867733967986;4413.7793110344355;4415.183191109655;4421;4425.977870110693;5414.133738601805;5418.945810541923;5420.91868621971;5421.186821976735;5421.810236641778;1336.7527007503643;1358.4566173530666;1358.9388477518535;1359.2456186816214;1360.4762166565745;820.1060843680417;865.8051938313829;897.6768363389175;903.9864402033975;904.5974541329177;4765.904681906342;4773.809047638125;4775.641826863;4782.784774685148;4789.473157952622;5584.246126772915;5585.273914391103;5586.469285417878;5588.692621905834;5595.776168953196;4759.309900064541;4767.713937163781;4768.260919557474;4775.2598347256235;4775.5224477552665;2960.18594886408;2996.5654980027775;3000.8649610767566;3002.9699703003125;3004.5042567976475;5323.920141197885;5326.7869285228935;5327.813526526553;5329.333833270841;5332.200169974535;5615.382307946123;5730.598858079978;5829.591928565044;5849.327327357323;5861.765529378862;5391.649542779707;5403.378611459732;5419.864503387447;5421.213923981;5429.755660995185;5676.2337084493065;5698.1452782083015;5744.425557444222;5749.482546570829;5752.884942301214;5570.387257401763;5571.944280557304;5573.414791446839;5574.665520068646;5574.888502230014;5412.079946409041;5415.783368665209;5417.918731219113;5421.647592906448;5425.159100339453;3723.3670276053676;3783.981080094582;3797.886063418102;3836.36699944506;3843.865464708722;5632.915506267327;5644.407337229696;5647.068233741551;5660.349059858169;5665.20687103814;5460.972695136657;5461.1262198048125;5465.59008074388;5469.945300547103;5470.343558772814;5433.076377015837;5450.345958485007;5452.918206226989;5456.208849716848;5476.644018138808;5321.521063104339;5344;5351.03681337363;5353.866153346197;5357.062514059946;5352.678839269656;5508.14623733322;5509.641873278224;5512.366077900932;5516.972415137899;5331.173668081454;5349;5351.5718742501285;5354.6787192767;5356.598255130959 05:11:32 INFO - PROCESS | 29683 | |5;yui.html;604.969751512424;608.5831205624148;618.4248995307305;629.1914889367164;652.0154566604429;10911.618093366733;10994;11112.388818614983;11118.722031949206;11124.165687573433;11409.20135590509;11544.191906566522;11552.422378881043;11612.477438515267;11614;545.6753231827057;642.2164958750317;645.1548471502335;656.0585559721791;657.2769953051653;661.2990230355814;662.0268205737582;665.4277321503528;666.1373521289942;678.2268214235775;676.1784431915222;681.0397339750953;681.2982627893277;681.7852376501411;715.81388838902;566.8752874367633;671.5030877150922;671.9563228390139;675.0717763075771;687.8761822871882;502.04360692880124;505.2244804225533;506.53398873036895;506.5694159964001;523.748600671676;10628.309159904582;10685.519151638195;10694.358338499715;10694.732631684192;10737.51681174349;10472.528736206888;10775.407352595605;10783.83824242637;10922.726931826688;11155.776884462346;8464.78838029048;8583.613737381833;9059.864102038475;9350.251979841665;9353.90646093544;3095.7987730797427;3123.9219019524467;3164.0666003529013;3164.335489547198;3224.67753224678;40550.18899621991;40585.18829623391;40962.38556421656;41368.58631413707;41772.79113604443;8121.345394572348;8257.463264887763;8380.958095209486;8457.238848503664;8574.871376929352;14030.859691403159;14374.425022999172;14398.568042958728;14422.85577144236;14504.419823207165;5608.691521966331;5728.656280623176;5825.79609713658;5861.208736820475;5877.471027607536;3520.718342532591;3590.425531914881;3614.855405783792;3640.508531348287;3642.21692336149;2446.584080706284;2467.3338198686615;2488.8382255153356;2489.9004039838564;2501;417.6491746932591;461.7483471508036;467.72638006765743;471.1284124369888;471.25776901379777;358.87618771523785;385.6586920575311;474.71042663974947;510.2117228881387;514.6628958032495;6290.1694237593265;6433.1636887205295;6524.184476940382;6594.802155935234;6676.9332306676315;403.2519676000976;425.1200015966919;484.8157700073949;485.74741134609803;517.097664575311;3197.635227913881;3230.2893363460003;3272.885449009273;3279.3113446176094;3370.224848284908;46261.5373846264;46450.53549464529;47078.29382559264;47484.28773568399;47493.28760068602;36597.451038234445;37011.63331316998;37426.62573374286;37543.62456375456;38043;37683.246335073694;38499.23001539954;39019.99999999943;39114.60885391109;39203.41194882079;7400;7582.469227154046;7610.6194690266375;7671.693132274647;7697.692092316244;28825;29064.564031539965;29069.563956541093;29591;29752.70247297586;36547.81726091352;36999.26001480009;37208.44187337246;37770.244595108496;38180.42729359117;8972;9036.683716069905;9107.908920910706;9161.129692679186;9520.095590918852;10486.895131048592;10599;10622.89377106219;10661.733456663645;10767.784644306914;7824.552138201444;9068.863967040368;9444.150026497648;9611.183049440875;9653.420794752337;7997.360211183208;8591.828163436572;8704.651813927372;8881.023087460246;8905.955470222607;9218;9283.907160928304;9286.489243091695;9394.107559781809;9523.23814094857;8192.221738934792;8647.524386158822;8652.341816021439;8788.868166977629;8853.203211710977;8311.376646751396;8329.541875196923;8411.53736544496;8625.353098517511;8684.175003374668 05:11:32 INFO - PROCESS | 29683 | __end_tp_report 05:11:32 INFO - PROCESS | 29683 | __start_cc_report 05:11:32 INFO - PROCESS | 29683 | _x_x_mozilla_cycle_collect,835 05:11:32 INFO - PROCESS | 29683 | __end_cc_report 05:11:32 INFO - PROCESS | 29683 | __startTimestamp1456837892602__endTimestamp 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | ------- Summary: start ------- 05:11:32 INFO - PROCESS | 29683 | Number of tests: 6 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#0] dojo.html Cycles:165 Average:4398.26 Median:4519.59 stddev:433.53 (9.6%) stddev-sans-first:411.35 05:11:32 INFO - PROCESS | 29683 | Values: 2603.1 2666.1 2671.3 2674.0 2696.7 4326.5 4411.9 4426.7 4441.6 4450.8 4447.6 4483.4 4508.1 4512.5 4519.3 4088.7 4102.1 4108.9 4112.8 4200.5 4138.4 4152.9 4188.8 4216.2 4225.8 4012.5 4037.2 4079.6 4130.3 4140.8 4046.7 4061.6 4066.2 4095.7 4107.3 4066.6 4068.7 4075.9 4081.4 4098.0 4291.5 4358.6 4402.7 4433.2 4461.8 4643.8 4670.6 4672.5 4673.9 4696.6 4604.9 4689.0 4693.2 4710.1 4723.5 4409.5 4453.8 4457.6 4483.5 4503.5 4851.4 4869.7 4870.5 4872.0 4889.2 4568.5 4659.3 4686.8 4690.2 4717.8 4778.8 4798.1 4799.9 4813.8 4839.8 4742.9 4747.1 4749.2 4750.4 4777.0 4587.6 4642.4 4727.0 4737.1 4770.3 3971.6 3989.7 3992.2 4017.1 4026.0 3496.2 3507.8 3511.6 3529.6 3536.1 4031.7 4075.6 4112.6 4151.8 4187.6 4779.6 4779.9 4782.5 4824.5 4825.9 4116.1 4151.9 4156.8 4160.3 4193.0 4135.7 4221.1 4292.0 4301.9 4309.4 4492.6 4519.6 4520.1 4530.5 4559.1 4685.9 4707.1 4759.6 4760.4 4771.8 4429.3 4477.5 4518.2 4532.1 4551.3 4670.9 4674.3 4678.1 4680.3 4703.1 4594.1 4748.4 4749.8 4753.4 4790.1 4616.5 4651.1 4658.4 4673.6 4694.7 4628.3 4628.4 4632.0 4633.8 4670.8 4393.6 4461.2 4524.3 4533.7 4575.2 4633.6 4665.8 4675.9 4709.5 4714.6 4514.5 4553.1 4553.6 4585.8 4591.5 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#1] ext.html Cycles:180 Average:38864.62 Median:31482.37 stddev:71318.80 (226.5%) stddev-sans-first:71460.62 05:11:32 INFO - PROCESS | 29683 | Values: 472.2 473.1 494.3 504.9 520.7 24229.9 24614.0 31926.5 32095.4 32289.0 33922.0 34310.8 34428.7 34477.7 34522.0 7493.3 7697.7 7698.9 7701.1 7703.5 6963.9 9946.8 10202.1 10215.3 10217.1 9680.2 9739.2 9781.4 9783.5 9810.1 9629.5 9737.0 9740.8 9778.2 9808.7 9546.4 9602.0 9684.0 9691.0 9692.6 31466.4 35124.3 35193.6 35239.6 35931.5 2307.5 2476.8 2675.4 2720.3 2974.7 26558.9 27123.9 27261.6 27656.3 28142.9 3064.2 3069.4 3091.0 3105.7 3161.5 221907.9 222476.0 222586.0 223297.0 223872.0 36456.5 37113.3 37145.0 37601.2 51560.7 35556.8 35675.1 35748.6 35766.3 35962.1 10839.6 10840.9 10846.7 10864.5 10893.6 7695.7 8564.9 8573.4 8642.7 8979.0 12197.7 12270.4 12276.5 12290.6 12397.6 4933.3 4993.0 5083.8 5103.6 5113.7 751.8 846.3 895.8 942.6 986.6 24019.0 25813.4 25829.9 25950.0 26159.9 849.6 925.7 945.4 994.7 1002.2 12927.5 13485.7 13501.9 13548.5 13632.7 252315.0 387445.0 395716.0 396468.0 397599.0 40169.6 40589.4 40741.0 40912.2 41342.4 1044.4 1048.8 1092.3 1112.7 1127.3 23916.8 25325.0 25601.2 25721.2 25787.2 33176.8 33888.3 34076.3 34226.5 34324.0 175191.0 175671.0 178202.1 181760.0 182500.0 23212.9 26673.0 27403.7 27665.3 28153.3 31038.2 31498.4 31585.8 31749.5 31928.8 28699.7 28988.3 29218.1 29785.4 30025.0 29779.6 29818.3 29836.6 30150.5 30259.8 29447.9 30190.5 30229.4 33450.3 34531.8 26044.7 26213.5 27188.3 28997.3 29407.9 22696.2 22859.8 23061.2 23186.5 23260.4 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#2] jquery.html Cycles:180 Average:19306.89 Median:48545.76 stddev:48640.18 (100.2%) stddev-sans-first:48755.69 05:11:32 INFO - PROCESS | 29683 | Values: 295.8 304.7 312.6 317.9 321.8 11244.6 14471.4 14490.7 15022.2 15044.2 12709.2 12875.9 12968.4 13048.9 13662.5 4665.2 4913.9 4914.4 4940.7 4942.9 3493.9 4773.9 4901.9 5319.1 5535.4 5456.5 5467.5 5480.0 5484.5 5491.5 5269.9 5444.5 5452.6 5488.0 5496.5 4826.7 4827.1 4828.7 4837.2 4840.4 18416.8 18443.8 18444.9 18470.2 18473.5 1855.3 1884.5 2065.6 2153.3 2345.6 11734.4 12132.5 12143.5 12366.3 12539.7 1620.3 1759.4 1777.5 1801.7 1832.8 48478.0 48613.5 48645.5 48820.0 49065.3 9110.6 9119.4 9192.2 9270.3 9273.7 10744.5 11568.9 11665.6 11686.0 11715.5 5705.3 5974.5 5983.5 6009.7 6242.4 5736.1 5751.6 5814.0 5820.5 5839.4 3741.9 3748.5 3764.4 3809.4 3840.9 1674.7 1681.5 1704.6 1741.9 1757.4 805.8 822.7 915.1 919.6 926.6 14901.3 15046.2 15079.7 15082.5 15087.5 802.0 817.5 834.0 845.2 849.0 8445.4 8570.3 8605.7 8629.7 8852.4 273419.0 274640.0 276759.0 277038.0 364286.0 57695.8 64653.7 65764.0 67415.3 68786.0 852.1 864.2 883.0 904.7 912.9 13814.5 13963.7 14281.6 14368.1 14418.5 20507.4 20848.7 24177.8 26162.9 28361.4 34784.8 35943.6 36054.1 37093.3 37854.6 6974.9 7039.5 7120.4 7143.3 7147.5 9185.8 9913.6 10189.5 10213.1 10441.8 8553.0 9031.9 9257.7 9808.3 9992.9 8516.4 9116.1 9296.6 9347.8 9365.5 9035.5 9133.4 9707.2 9720.8 10325.9 7066.9 7182.9 7275.6 7277.1 7297.0 9387.5 9668.3 10021.2 10045.2 10337.4 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#3] mootools.html Cycles:180 Average:4665.90 Median:5678.16 stddev:2500.53 (44.0%) stddev-sans-first:2493.81 05:11:32 INFO - PROCESS | 29683 | Values: 1179.7 1249.2 1272.2 1290.5 1551.8 5872.4 6625.9 6754.5 6785.6 6794.4 6747.8 6895.4 6914.7 6919.8 6926.2 1708.7 1758.4 1760.4 1983.8 2009.8 1968.7 2031.5 2032.8 2033.6 2037.2 1947.0 1957.4 1976.8 1976.8 1977.4 1822.7 1823.1 1825.9 1827.2 1829.3 1958.8 1965.1 1968.9 2005.0 2015.6 6991.9 7005.6 7006.3 7007.5 7020.1 3692.4 3767.7 3767.8 3768.8 3773.0 2590.2 2622.0 2642.1 2656.9 2674.4 857.9 876.4 888.8 892.9 1617.7 8941.3 9005.5 9008.6 9018.7 9026.5 3507.3 3531.8 3606.7 3668.3 3687.9 7485.2 7530.5 7530.8 7550.9 7558.1 3784.7 3806.4 3810.9 3815.6 3815.6 2963.6 3430.8 3470.2 3477.8 3519.6 2941.0 3014.9 3026.4 3035.9 3036.7 865.0 873.1 883.0 883.3 889.2 983.9 993.7 1004.2 1006.1 1039.4 6368.8 6462.5 6472.3 6483.9 6494.9 402.0 407.5 415.9 423.2 424.1 4864.7 4896.4 4922.4 4927.9 4991.2 8149.7 8247.3 8347.1 8374.1 8396.5 8252.5 8336.7 8361.3 8364.3 8410.9 6478.5 6525.8 6598.8 6623.3 6680.9 6128.7 6142.1 6149.0 6161.4 6183.5 7267.6 7455.7 7530.5 7639.4 7657.2 7639.7 7690.2 7896.4 7961.8 7992.5 4913.4 5349.8 5510.9 5604.5 5639.5 6298.3 6381.9 6382.0 6387.8 6391.2 5561.8 5569.8 5598.6 5662.5 5714.4 5549.7 5643.8 5693.8 5782.5 5792.7 5817.9 6015.8 6128.2 6152.3 6154.2 5501.9 5558.9 5572.3 5574.7 5585.4 5653.3 5739.5 5743.9 5750.9 5751.7 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#4] prototype.html Cycles:180 Average:4497.53 Median:5197.69 stddev:1348.88 (26.0%) stddev-sans-first:1315.01 05:11:32 INFO - PROCESS | 29683 | Values: 280.6 281.8 283.5 288.4 289.8 5165.8 5212.9 5214.9 5215.6 5237.3 5094.1 5172.3 5174.9 5176.6 5182.4 3798.8 3912.3 3950.3 3973.9 4047.7 3991.1 4031.8 4052.4 4053.6 4054.1 4020.5 4020.8 4025.3 4029.7 4032.0 3788.9 3879.4 3947.1 3950.2 3974.8 3442.3 3449.1 3462.5 3469.1 3477.6 4893.4 4976.2 4979.2 4985.1 4992.2 4558.9 4567.2 4568.8 4572.0 4573.2 5418.3 5421.8 5431.4 5434.3 5439.2 3797.1 3808.8 3812.6 3815.3 3815.4 5461.5 5693.6 5700.9 5707.8 5711.7 3704.4 3712.2 3718.2 3720.2 3720.7 3773.8 3774.3 3774.4 3776.7 3777.0 4408.9 4413.8 4415.2 4421.0 4426.0 5414.1 5418.9 5420.9 5421.2 5421.8 1336.8 1358.5 1358.9 1359.2 1360.5 820.1 865.8 897.7 904.0 904.6 4765.9 4773.8 4775.6 4782.8 4789.5 5584.2 5585.3 5586.5 5588.7 5595.8 4759.3 4767.7 4768.3 4775.3 4775.5 2960.2 2996.6 3000.9 3003.0 3004.5 5323.9 5326.8 5327.8 5329.3 5332.2 5615.4 5730.6 5829.6 5849.3 5861.8 5391.6 5403.4 5419.9 5421.2 5429.8 5676.2 5698.1 5744.4 5749.5 5752.9 5570.4 5571.9 5573.4 5574.7 5574.9 5412.1 5415.8 5417.9 5421.6 5425.2 3723.4 3784.0 3797.9 3836.4 3843.9 5632.9 5644.4 5647.1 5660.3 5665.2 5461.0 5461.1 5465.6 5469.9 5470.3 5433.1 5450.3 5452.9 5456.2 5476.6 5321.5 5344.0 5351.0 5353.9 5357.1 5352.7 5508.1 5509.6 5512.4 5517.0 5331.2 5349.0 5351.6 5354.7 5356.6 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | [#5] yui.html Cycles:180 Average:11330.36 Median:485.28 stddev:12966.29 (2671.9%) stddev-sans-first:12977.65 05:11:32 INFO - PROCESS | 29683 | Values: 605.0 608.6 618.4 629.2 652.0 10911.6 10994.0 11112.4 11118.7 11124.2 11409.2 11544.2 11552.4 11612.5 11614.0 545.7 642.2 645.2 656.1 657.3 661.3 662.0 665.4 666.1 678.2 676.2 681.0 681.3 681.8 715.8 566.9 671.5 672.0 675.1 687.9 502.0 505.2 506.5 506.6 523.7 10628.3 10685.5 10694.4 10694.7 10737.5 10472.5 10775.4 10783.8 10922.7 11155.8 8464.8 8583.6 9059.9 9350.3 9353.9 3095.8 3123.9 3164.1 3164.3 3224.7 40550.2 40585.2 40962.4 41368.6 41772.8 8121.3 8257.5 8381.0 8457.2 8574.9 14030.9 14374.4 14398.6 14422.9 14504.4 5608.7 5728.7 5825.8 5861.2 5877.5 3520.7 3590.4 3614.9 3640.5 3642.2 2446.6 2467.3 2488.8 2489.9 2501.0 417.6 461.7 467.7 471.1 471.3 358.9 385.7 474.7 510.2 514.7 6290.2 6433.2 6524.2 6594.8 6676.9 403.3 425.1 484.8 485.7 517.1 3197.6 3230.3 3272.9 3279.3 3370.2 46261.5 46450.5 47078.3 47484.3 47493.3 36597.5 37011.6 37426.6 37543.6 38043.0 37683.2 38499.2 39020.0 39114.6 39203.4 7400.0 7582.5 7610.6 7671.7 7697.7 28825.0 29064.6 29069.6 29591.0 29752.7 36547.8 36999.3 37208.4 37770.2 38180.4 8972.0 9036.7 9107.9 9161.1 9520.1 10486.9 10599.0 10622.9 10661.7 10767.8 7824.6 9068.9 9444.2 9611.2 9653.4 7997.4 8591.8 8704.7 8881.0 8906.0 9218.0 9283.9 9286.5 9394.1 9523.2 8192.2 8647.5 8652.3 8788.9 8853.2 8311.4 8329.5 8411.5 8625.4 8684.2 05:11:32 INFO - PROCESS | 29683 | -------- Summary: end -------- 05:11:32 INFO - PROCESS | 29683 | 05:11:32 INFO - PROCESS | 29683 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:32 INFO - PROCESS | 29683 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:32 INFO - PROCESS | 29683 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:32 INFO - PROCESS | 29683 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:32 INFO - PROCESS | 29683 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:33 INFO - TEST-INFO | 29683: exit 0 05:11:33 INFO - TEST-OK | dromaeo_css | took 1118429ms 05:11:33 INFO - TEST-START | kraken 05:11:33 INFO - operating with platform_type : linux_ 05:11:33 INFO - Initialising browser for kraken test... 05:11:33 INFO - TEST-INFO | started process 29865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHcm16/profile http://localhost:37732/getInfo.html) 05:11:38 INFO - PROCESS | 29865 | __metrics Screen width/height:1600/1200 05:11:38 INFO - PROCESS | 29865 | colorDepth:24 05:11:38 INFO - PROCESS | 29865 | Browser inner width/height: 1024/697 05:11:38 INFO - PROCESS | 29865 | __metrics 05:11:39 INFO - PROCESS | 29865 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:39 INFO - PROCESS | 29865 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:11:40 INFO - TEST-INFO | 29865: exit 0 05:11:40 INFO - Browser initialized. 05:11:40 INFO - Running cycle 1/1 for kraken test... 05:11:40 INFO - TEST-INFO | started process 29948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHcm16/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:52 INFO - PROCESS | 29948 | RSS: Main: 153681920 05:11:52 INFO - PROCESS | 29948 | 05:11:55 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37732/tests/kraken/driver.html?testName=audio-beat-detection) 05:11:55 INFO - PROCESS | 29948 | RSS: Main: 197406720 05:11:55 INFO - PROCESS | 29948 | 05:11:58 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37732/tests/kraken/driver.html?testName=audio-dft) 05:11:59 INFO - PROCESS | 29948 | RSS: Main: 185626624 05:11:59 INFO - PROCESS | 29948 | 05:12:02 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37732/tests/kraken/driver.html?testName=audio-fft) 05:12:02 INFO - PROCESS | 29948 | RSS: Main: 171175936 05:12:02 INFO - PROCESS | 29948 | 05:12:04 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37732/tests/kraken/driver.html?testName=audio-oscillator) 05:12:05 INFO - PROCESS | 29948 | RSS: Main: 174551040 05:12:05 INFO - PROCESS | 29948 | 05:12:07 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:08 INFO - PROCESS | 29948 | RSS: Main: 173826048 05:12:08 INFO - PROCESS | 29948 | 05:12:11 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37732/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:12 INFO - PROCESS | 29948 | RSS: Main: 176304128 05:12:12 INFO - PROCESS | 29948 | 05:12:15 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37732/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:16 INFO - PROCESS | 29948 | RSS: Main: 175153152 05:12:16 INFO - PROCESS | 29948 | 05:12:18 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37732/tests/kraken/driver.html?testName=json-parse-financial) 05:12:19 INFO - PROCESS | 29948 | RSS: Main: 176828416 05:12:19 INFO - PROCESS | 29948 | 05:12:21 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:21 INFO - PROCESS | 29948 | RSS: Main: 186150912 05:12:21 INFO - PROCESS | 29948 | 05:12:23 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:24 INFO - PROCESS | 29948 | RSS: Main: 183853056 05:12:24 INFO - PROCESS | 29948 | 05:12:26 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:27 INFO - PROCESS | 29948 | RSS: Main: 193699840 05:12:27 INFO - PROCESS | 29948 | 05:12:29 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:30 INFO - PROCESS | 29948 | RSS: Main: 197468160 05:12:30 INFO - PROCESS | 29948 | 05:12:32 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:12:33 INFO - PROCESS | 29948 | RSS: Main: 198729728 05:12:33 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | Cycle 1(1): loaded http://localhost:37732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37732/tests/kraken/driver.html?testName=ai-astar) 05:12:35 INFO - PROCESS | 29948 | RSS: Main: 257597440 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | __start_tp_report 05:12:35 INFO - PROCESS | 29948 | _x_x_mozilla_page_load 05:12:35 INFO - PROCESS | 29948 | _x_x_mozilla_page_load_details 05:12:35 INFO - PROCESS | 29948 | |i|pagename|runs| 05:12:35 INFO - PROCESS | 29948 | |0;ai-astar;113;115;108;113;114;115;103;112;112;114 05:12:35 INFO - PROCESS | 29948 | |1;audio-beat-detection;157;133;159;174;139;169;152;136;170;134 05:12:35 INFO - PROCESS | 29948 | |2;audio-dft;163;164;163;162;161;162;163;164;163;162 05:12:35 INFO - PROCESS | 29948 | |3;audio-fft;74;75;120;96;73;73;75;108;106;75 05:12:35 INFO - PROCESS | 29948 | |4;audio-oscillator;96;95;146;95;95;95;142;95;95;138 05:12:35 INFO - PROCESS | 29948 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;118 05:12:35 INFO - PROCESS | 29948 | |6;imaging-darkroom;146;146;147;146;147;147;147;147;146;147 05:12:35 INFO - PROCESS | 29948 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;96 05:12:35 INFO - PROCESS | 29948 | |8;json-parse-financial;69;68;66;68;67;68;67;78;65;65 05:12:35 INFO - PROCESS | 29948 | |9;json-stringify-tinderbox;70;73;70;70;70;71;71;71;73;71 05:12:35 INFO - PROCESS | 29948 | |10;stanford-crypto-aes;87;84;85;84;84;84;84;83;85;84 05:12:35 INFO - PROCESS | 29948 | |11;stanford-crypto-ccm;123;128;120;127;119;138;124;120;123;136 05:12:35 INFO - PROCESS | 29948 | |12;stanford-crypto-pbkdf2;150;138;154;151;149;135;147;148;155;152 05:12:35 INFO - PROCESS | 29948 | |13;stanford-crypto-sha256-iterative;70;70;70;71;70;71;70;71;70;69 05:12:35 INFO - PROCESS | 29948 | __end_tp_report 05:12:35 INFO - PROCESS | 29948 | __start_cc_report 05:12:35 INFO - PROCESS | 29948 | _x_x_mozilla_cycle_collect,1157 05:12:35 INFO - PROCESS | 29948 | __end_cc_report 05:12:35 INFO - PROCESS | 29948 | __startTimestamp1456837955442__endTimestamp 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | ------- Summary: start ------- 05:12:35 INFO - PROCESS | 29948 | Number of tests: 14 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.73 (3.3%) stddev-sans-first:3.93 05:12:35 INFO - PROCESS | 29948 | Values: 113.0 115.0 108.0 113.0 114.0 115.0 103.0 112.0 112.0 114.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.00 stddev:15.92 (10.1%) stddev-sans-first:16.79 05:12:35 INFO - PROCESS | 29948 | Values: 157.0 133.0 159.0 174.0 139.0 169.0 152.0 136.0 170.0 134.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:12:35 INFO - PROCESS | 29948 | Values: 163.0 164.0 163.0 162.0 161.0 162.0 163.0 164.0 163.0 162.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#3] audio-fft Cycles:10 Average:87.50 Median:74.50 stddev:18.14 (24.4%) stddev-sans-first:18.57 05:12:35 INFO - PROCESS | 29948 | Values: 74.0 75.0 120.0 96.0 73.0 73.0 75.0 108.0 106.0 75.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.00 stddev:22.71 (23.9%) stddev-sans-first:23.58 05:12:35 INFO - PROCESS | 29948 | Values: 96.0 95.0 146.0 95.0 95.0 95.0 142.0 95.0 95.0 138.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:12:35 INFO - PROCESS | 29948 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:12:35 INFO - PROCESS | 29948 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:12:35 INFO - PROCESS | 29948 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.00 stddev:3.73 (5.5%) stddev-sans-first:3.94 05:12:35 INFO - PROCESS | 29948 | Values: 69.0 68.0 66.0 68.0 67.0 68.0 67.0 78.0 65.0 65.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:1.15 (1.6%) stddev-sans-first:1.17 05:12:35 INFO - PROCESS | 29948 | Values: 70.0 73.0 70.0 70.0 70.0 71.0 71.0 71.0 73.0 71.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:0.60 05:12:35 INFO - PROCESS | 29948 | Values: 87.0 84.0 85.0 84.0 84.0 84.0 84.0 83.0 85.0 84.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.50 stddev:6.60 (5.3%) stddev-sans-first:6.92 05:12:35 INFO - PROCESS | 29948 | Values: 123.0 128.0 120.0 127.0 119.0 138.0 124.0 120.0 123.0 136.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.50 stddev:6.54 (4.3%) stddev-sans-first:6.89 05:12:35 INFO - PROCESS | 29948 | Values: 150.0 138.0 154.0 151.0 149.0 135.0 147.0 148.0 155.0 152.0 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 05:12:35 INFO - PROCESS | 29948 | Values: 70.0 70.0 70.0 71.0 70.0 71.0 70.0 71.0 70.0 69.0 05:12:35 INFO - PROCESS | 29948 | -------- Summary: end -------- 05:12:35 INFO - PROCESS | 29948 | 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:35 INFO - PROCESS | 29948 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:12:36 INFO - TEST-INFO | 29948: exit 0 05:12:36 INFO - TEST-OK | kraken | took 63130ms 05:12:36 INFO - SUITE-END | took 1181s 05:12:36 INFO - Completed test suite (00:19:41) 05:12:36 INFO - Working with test: dromaeo_css 05:12:36 INFO - Generating results file: dromaeo_css 05:12:36 INFO - Working with test: kraken 05:12:36 INFO - Generating results file: kraken 05:12:36 INFO - javascript benchmark 05:12:36 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:12:36 INFO - process_Request line: dromaeo_css 5807.96 graph.html#tests=[[72,94,35]] 05:12:36 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:12:36 INFO - process_Request line: kraken 1550.30 graph.html#tests=[[232,94,35]] 05:12:36 INFO - RETURN: dromaeo_css: 5807.96 05:12:36 INFO - RETURN: kraken: 1550.30 05:12:36 INFO - javascript benchmark 05:12:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2603.062897356951, 2666.066876593193, 2671.265402014447, 2673.973260267398, 2696.689880663723, 4326.545712700161, 4411.889702757425, 4426.734395936242, 4441.578050085245, 4450.821967121311, 4447.555244475551, 4483.4171557697455, 4508.120916421299, 4512.481064677563, 4519.254323036695, 4088.693347998897, 4102.118044620406, 4108.876733697994, 4112.814923328458, 4200.51694055183, 4138.4413104231, 4152.875413737577, 4188.811503482335, 4216.177845320164, 4225.809838557257, 4012.518497780285, 4037.1723796621914, 4079.5512493625974, 4130.318497447917, 4140.772257525835, 4046.719681908549, 4061.5938406159444, 4066.207089617526, 4095.692823038254, 4107.322291821846, 4066.552679205285, 4068.7355321903983, 4075.8777236682945, 4081.4498997547503, 4097.959020409788, 4291.549387314319, 4358.564143585616, 4402.691811573191, 4433.246348120827, 4461.821527138911, 4643.767811609406, 4670.556297151765, 4672.486026537078, 4673.949881381945, 4696.577308042259, 4604.930926036079, 4688.953110468886, 4693.24908014716, 4710.105080034782, 4723.504032076651, 4409.536998615131, 4453.799579018952, 4457.64338852891, 4483.50681425043, 4503.54964503547, 4851.36932198819, 4869.732164730903, 4870.464248932614, 4871.975640121776, 4889.193283108319, 4568.497465278817, 4659.254519276899, 4686.835960741358, 4690.202665546865, 4717.834875779331, 4778.761061946889, 4798.136335459581, 4799.880002999953, 4813.807447702123, 4839.758012099381, 4742.881427964328, 4747.074320507468, 4749.216379297446, 4750.395783601925, 4776.9761151194025, 4587.610053145453, 4642.37327960721, 4727.0, 4737.052589482118, 4770.332153498513, 3971.6425521703186, 3989.7007724420782, 3992.2215168041953, 4017.0961533655277, 4026.0, 3496.1958749487762, 3507.7544571879725, 3511.613722490524, 3529.6293889141784, 3536.0629433200224, 4031.717779755389, 4075.633193012584, 4112.609302116294, 4151.813168407429, 4187.602177793105, 4779.641526885497, 4779.856604301876, 4782.450018247877, 4824.469308376076, 4825.9034819304115, 4116.094459218967, 4151.875443736692, 4156.771377574262, 4160.292750232467, 4193.035601811601, 4135.710500265012, 4221.113566151082, 4292.0, 4301.935470967938, 4309.41822853917, 4492.573205545468, 4519.593236608721, 4520.095980803852, 4530.546945305443, 4559.065391594781, 4685.882852928704, 4707.129181101507, 4759.643026773075, 4760.381150450419, 4771.832985845479, 4429.269170586817, 4477.462704475483, 4518.209313370213, 4532.138893610204, 4551.3173024046655, 4670.883227919193, 4674.322223277673, 4678.059641275746, 4680.297955306732, 4703.129920964632, 4594.104149690778, 4748.430188377417, 4749.786259618257, 4753.382060332273, 4790.137775200497, 4616.515265897033, 4651.093036857916, 4658.417697787777, 4673.602743766682, 4694.718316900997, 4628.328892310664, 4628.39830821991, 4631.976840115778, 4633.814647414066, 4670.766461676971, 4393.582609652078, 4461.174682683714, 4524.298733696282, 4533.705309154894, 4575.1993401153995, 4633.559811817872, 4665.813367465264, 4675.906481870412, 4709.48195698466, 4714.5521175488275, 4514.503404625423, 4553.11214313219, 4553.6357091433265, 4585.770711464346, 4591.517890621437], "unit": "score", "name": "dojo.html", "value": 4373.0527924052685}, {"lowerIsBetter": false, "replicates": [472.1736960319439, 473.1105521619355, 494.3326509212563, 504.90406822703704, 520.7292208051813, 24229.878850605743, 24614.0, 31926.52110218343, 32095.35809283813, 32289.0, 33922.0, 34310.8284458578, 34428.65571344286, 34477.65522344776, 34522.0, 7493.288137626931, 7697.692092316301, 7698.884516732253, 7701.114371847253, 7703.46075774696, 6963.895541566881, 9946.751331216741, 10202.132818710419, 10215.284930054899, 10217.131543818785, 9680.177184939288, 9739.220862331033, 9781.364211326276, 9783.510824458785, 9810.068043535888, 9629.470379129145, 9737.026297370241, 9740.805183896353, 9778.168855647278, 9808.705738827846, 9546.3794853335, 9601.951990240004, 9683.951580242054, 9690.95154524223, 9692.612295508172, 31466.37067258642, 35124.29751404983, 35193.64806351929, 35239.64760352415, 35931.4610280846, 2307.492351682627, 2476.7647073527987, 2675.3712877473777, 2720.2519307190482, 2974.7025297470295, 26558.867205664043, 27123.86438067817, 27261.591076133675, 27656.308592285353, 28142.859285703442, 3064.172673378175, 3069.416810805962, 3090.9845450772827, 3105.658377578487, 3161.462551366273, 221907.89046054828, 222476.0, 222586.0, 223297.0, 223872.0, 36456.453153202725, 37113.25773484515, 37145.0, 37601.24797504034, 51560.74219628878, 35556.82221588876, 35675.10812229715, 35748.642513575054, 35766.28467430637, 35962.10094747652, 10839.620613278497, 10840.945795270973, 10846.67459976202, 10864.456777161111, 10893.618723344645, 7695.653695583712, 8564.871526927102, 8573.399862009725, 8642.654293828176, 8979.0, 12197.69505762363, 12270.447829847679, 12276.508939642314, 12290.631281061582, 12397.62807115788, 4933.333999910038, 4992.975035124801, 5083.771230294646, 5103.591712662978, 5113.71874546896, 751.8421131562324, 846.34408333542, 895.8297923394534, 942.6323733743845, 986.6448078691665, 24019.0, 25813.3546661335, 25829.870850646003, 25950.0, 26159.869200654255, 849.5539841583218, 925.6575067225169, 945.4232917920064, 994.7115336552318, 1002.2282842211602, 12927.5475358362, 13485.730285394236, 13501.932490337485, 13548.45806167762, 13632.65918352049, 252315.0, 387445.0, 395716.0, 396468.0, 397599.0, 40169.59830401717, 40589.39115913264, 40741.0, 40912.181756364706, 41342.37986430206, 1044.4099084017505, 1048.8479170520231, 1092.257265059751, 1112.710695219249, 1127.312339472921, 23916.760832391454, 25324.97400207942, 25601.23196304114, 25721.228363149134, 25787.226383208534, 33176.83411582927, 33888.322233554696, 34076.31847362989, 34226.48660270148, 34324.0, 175191.0, 175671.0, 178202.10898945422, 181760.0, 182500.0, 23212.883935580216, 26673.0, 27403.725962740118, 27665.308367290174, 28153.296167595156, 31038.22404439907, 31498.37003259968, 31585.84207079042, 31749.523757144125, 31928.84035579807, 28699.713002869703, 28988.27529311784, 29218.123456296344, 29785.404291913608, 30025.0, 29779.55330670085, 29818.254543636584, 29836.552451713676, 30150.54774178433, 30259.848700756356, 29447.852760736918, 30190.54714179333, 30229.395412092075, 33450.330993380485, 34531.755435896586, 26044.73955260423, 26213.475730485665, 27188.26162646108, 28997.275068123465, 29407.85296073506, 22696.205632802772, 22859.771402285765, 23061.19285824988, 23186.536269274184, 23260.418489537897], "unit": "score", "name": "ext.html", "value": 15336.846998145786}, {"lowerIsBetter": false, "replicates": [295.7885112144816, 304.70443669640457, 312.6092384519351, 317.93641271745656, 321.7747576696313, 11244.606438774645, 14471.421143154274, 14490.710185796277, 15022.173780442085, 15044.172570508632, 12709.23744575326, 12875.935620321909, 12968.351582420888, 13048.93475532621, 13662.453501859914, 4665.183592871251, 4913.852584422473, 4914.3611330527165, 4940.6788558743565, 4942.901141977159, 3493.8602455901732, 4773.928391074137, 4901.877453063684, 5319.122344813101, 5535.446455354472, 5456.454354564551, 5467.480589344026, 5480.0, 5484.533814625742, 5491.505764481196, 5269.920951185716, 5444.50999410053, 5452.563794896399, 5488.0, 5496.532794712454, 4826.734529600871, 4827.106985207748, 4828.7102773833685, 4837.2260438329695, 4840.394950631171, 18416.815831841643, 18443.815561844345, 18444.90777546117, 18470.16884240199, 18473.538161545934, 1855.313533992418, 1884.4911873794, 2065.5972085443345, 2153.2894144932134, 2345.64815277708, 11734.413279335999, 12132.45403956824, 12143.453544590515, 12366.319852408114, 12539.686507837287, 1620.2627804348992, 1759.3930094117509, 1777.4578753480184, 1801.7387478815629, 1832.8075552066973, 48478.0, 48613.513864861256, 48645.51354486445, 48819.99999999964, 49065.264021039715, 9110.59002344896, 9119.407238529475, 9192.172704456498, 9270.30472714549, 9273.721788346225, 10744.462776861126, 11568.942155289169, 11665.591704290478, 11686.0, 11715.472803723853, 5705.258316418839, 5974.462298393166, 5983.461488466059, 6009.729562169713, 6242.438180563771, 5736.082226843685, 5751.626144300607, 5814.011618024946, 5820.534357251409, 5839.445252700986, 3741.9064523386587, 3748.475213470116, 3764.3600587899573, 3809.3904975203836, 3840.884773456745, 1674.7487876818575, 1681.5039563328846, 1704.6164612961984, 1741.8519425848692, 1757.393699173783, 805.8186907945666, 822.7326119011345, 915.0666320353203, 919.5678031325266, 926.6061923682408, 14901.329440175217, 15046.247687615794, 15079.698406031817, 15082.472113475975, 15087.547373578811, 801.9599020048975, 817.4604760857806, 833.9583020848934, 845.1675100026468, 848.9617967191491, 8445.366597505088, 8570.314374849997, 8605.741827745178, 8629.654813807378, 8852.424592401474, 273419.0, 274640.0, 276759.0, 277038.0, 364286.0, 57695.846083078104, 64653.67673161698, 65764.0, 67415.3258467409, 68786.0, 852.1095455249404, 864.2222000199745, 883.0108708449387, 904.7421484876778, 912.8904531456135, 13814.516491922734, 13963.650908727363, 14281.64295892611, 14368.13791172533, 14418.495352662607, 20507.38477845667, 20848.687269690665, 24177.758222418255, 26162.86918565395, 28361.43277134487, 34784.82607586946, 35943.64056359507, 36054.098647534025, 37093.258134836615, 37854.62145378621, 6974.895376569254, 7039.472039596948, 7120.394766444911, 7143.285671432815, 7147.53541019832, 9185.77035574116, 9913.603455861685, 10189.54147063369, 10213.131883789962, 10441.843372349269, 8552.957235213784, 9031.864522032043, 9257.67598134062, 9808.264380171373, 9992.850107248252, 8516.361272904433, 9116.1339672731, 9296.6281348748, 9347.766305842408, 9365.531723413938, 9035.548222588975, 9133.406328588886, 9707.174890134418, 9720.805583888425, 10325.896741032793, 7066.858662826818, 7182.928170718435, 7275.6362181889635, 7277.053982982178, 7297.0, 9387.530623468936, 9668.274879383933, 10021.248406369697, 10045.196384289386, 10337.37975721459], "unit": "score", "name": "jquery.html", "value": 7340.725586958932}, {"lowerIsBetter": false, "replicates": [1179.746354533775, 1249.1505776072272, 1272.236658005197, 1290.509606349587, 1551.7827504149427, 5872.383399743024, 6625.86748265035, 6754.49341299402, 6785.6267905265195, 6794.388505034546, 6747.831304217397, 6895.44836413087, 6914.723411063552, 6919.792406227822, 6926.203486599043, 1708.666809972056, 1758.4373000639737, 1760.3750668512685, 1983.821456068957, 2009.7688765791902, 1968.675168597187, 2031.4616626593966, 2032.7865574114726, 2033.613613413454, 2037.246218899002, 1946.9902650486729, 1957.4029920874127, 1976.7924367941375, 1976.8220860122585, 1977.4166620846884, 1822.662807380639, 1823.0975667044831, 1825.9087045647732, 1827.1869018286802, 1829.268292682924, 1958.7649482062102, 1965.105876826055, 1968.9015549222481, 2005.0476023888682, 2015.6271089848278, 6991.930080699179, 7005.649717514155, 7006.299370062953, 7007.509474336798, 7020.05229294049, 3692.40921452569, 3767.7362584619086, 3767.830447629863, 3768.773873567595, 3773.0, 2590.2223266009123, 2621.9868900655374, 2642.141304076183, 2656.933576660599, 2674.3581540430155, 857.8541647919868, 876.3646356391629, 888.7511496780912, 892.8526793079199, 1617.6926383987004, 8941.284697224271, 9005.459672419676, 9008.639654413815, 9018.684346047923, 9026.548672566345, 3507.2985402919517, 3531.752777305564, 3606.693431058337, 3668.284684486553, 3687.870924517629, 7485.176630570633, 7530.548167109991, 7530.849383012309, 7550.886736698954, 7558.055243094614, 3784.7161462890394, 3806.371948628501, 3810.8856734298015, 3815.561210460777, 3815.618438156162, 2963.6443626764926, 3430.8456119474185, 3470.1671598816606, 3477.8434970426392, 3519.6128425873135, 2940.9852950735535, 3014.8643311051055, 3026.424979253935, 3035.8918994566825, 3036.6963303669454, 865.0268447996004, 873.0876234335135, 883.0198479687542, 883.3463237204422, 889.1819526036062, 983.9458829764432, 993.6671215143008, 1004.2417974429259, 1006.074411541369, 1039.4387031003173, 6368.808935731936, 6462.450691691259, 6472.3204063573585, 6483.870322593616, 6494.870102597922, 402.01105281009046, 407.4987765048947, 415.89810496428566, 423.21916064860284, 424.0649368143237, 4864.73243971585, 4896.387951506062, 4922.384701912261, 4927.852164435073, 4991.176455884738, 8149.674013039531, 8247.340212782963, 8347.123552027071, 8374.078851326349, 8396.538190399464, 8252.546109964009, 8336.66653333872, 8361.331093512505, 8364.289035432057, 8410.873836892451, 6478.481721462272, 6525.771597994048, 6598.802035938929, 6623.271440141581, 6680.899786503206, 6128.693565321627, 6142.109394137736, 6149.0, 6161.44546990773, 6183.474404675653, 7267.600281984542, 7455.739049133254, 7530.548167109991, 7639.350655194148, 7657.157712651492, 7639.732609358646, 7690.230976902265, 7896.407769417202, 7961.800954976172, 7992.5204487730925, 4913.385826771653, 5349.786008559614, 5510.862228444321, 5604.467575580314, 5639.520640745583, 6298.275698294571, 6381.93618063832, 6382.0, 6387.840303992437, 6391.201099862517, 5561.777528898799, 5569.805056822992, 5598.636088654224, 5662.546996240373, 5714.3999880012, 5549.667019978814, 5643.802466913638, 5693.772249109989, 5782.479576837936, 5792.652440853562, 5817.883642327045, 6015.819525414245, 6128.233970753656, 6152.261728592597, 6154.1999540059505, 5501.917471237854, 5558.861028474321, 5572.275604171432, 5574.665520068809, 5585.413531579125, 5653.265075540154, 5739.483446489836, 5743.9138412923, 5750.913736293875, 5751.7411716472025], "unit": "score", "name": "mootools.html", "value": 3742.797811262379}, {"lowerIsBetter": false, "replicates": [280.5833337493822, 281.7703571589155, 283.54349497309335, 288.3842995205236, 289.77687180870714, 5165.793368265275, 5212.947870521293, 5214.8696282592955, 5215.58275337973, 5237.266782650432, 5094.133997220472, 5172.327597412331, 5174.922376164361, 5176.611754118447, 5182.429932707409, 3798.810059497028, 3912.2762288976487, 3950.328444164499, 3973.8807835764974, 4047.7368971016936, 3991.1219531702977, 4031.818568164425, 4052.3516237402023, 4053.5743746906446, 4054.0878302381875, 4020.5376381716037, 4020.819063142151, 4025.2553277643583, 4029.717919745619, 4031.97984010081, 3788.886333410002, 3879.398693202558, 3947.072437977073, 3950.1902110067367, 3974.7813870237123, 3442.277121804424, 3449.085992212066, 3462.549868517102, 3469.09803451102, 3477.6348483409383, 4893.437254715717, 4976.228684553864, 4979.228219625964, 4985.127602669555, 4992.151334273182, 4558.8860278492975, 4567.177907976563, 4568.794404251817, 4572.01701634147, 4573.245414506602, 5418.268533747933, 5421.783128674848, 5431.375391829951, 5434.347878254595, 5439.211314359435, 3797.1076796952693, 3808.7905165215902, 3812.618738126193, 3815.3323168445413, 3815.351390263634, 5461.5357694596005, 5693.601447898649, 5700.885982280372, 5707.800226992077, 5711.742971566289, 3704.407294832814, 3712.2204337089515, 3718.2377612589353, 3720.1815600567834, 3720.6837418819705, 3773.7924414156937, 3774.2828862516035, 3774.3960966245268, 3776.66010059096, 3777.036855601804, 4408.867733967986, 4413.7793110344355, 4415.183191109655, 4421.0, 4425.977870110693, 5414.133738601805, 5418.945810541923, 5420.91868621971, 5421.186821976735, 5421.810236641778, 1336.7527007503643, 1358.4566173530666, 1358.9388477518535, 1359.2456186816214, 1360.4762166565745, 820.1060843680417, 865.8051938313829, 897.6768363389175, 903.9864402033975, 904.5974541329177, 4765.904681906342, 4773.809047638125, 4775.641826863, 4782.784774685148, 4789.473157952622, 5584.246126772915, 5585.273914391103, 5586.469285417878, 5588.692621905834, 5595.776168953196, 4759.309900064541, 4767.713937163781, 4768.260919557474, 4775.2598347256235, 4775.5224477552665, 2960.18594886408, 2996.5654980027775, 3000.8649610767566, 3002.9699703003125, 3004.5042567976475, 5323.920141197885, 5326.7869285228935, 5327.813526526553, 5329.333833270841, 5332.200169974535, 5615.382307946123, 5730.598858079978, 5829.591928565044, 5849.327327357323, 5861.765529378862, 5391.649542779707, 5403.378611459732, 5419.864503387447, 5421.213923981, 5429.755660995185, 5676.2337084493065, 5698.1452782083015, 5744.425557444222, 5749.482546570829, 5752.884942301214, 5570.387257401763, 5571.944280557304, 5573.414791446839, 5574.665520068646, 5574.888502230014, 5412.079946409041, 5415.783368665209, 5417.918731219113, 5421.647592906448, 5425.159100339453, 3723.3670276053676, 3783.981080094582, 3797.886063418102, 3836.36699944506, 3843.865464708722, 5632.915506267327, 5644.407337229696, 5647.068233741551, 5660.349059858169, 5665.20687103814, 5460.972695136657, 5461.1262198048125, 5465.59008074388, 5469.945300547103, 5470.343558772814, 5433.076377015837, 5450.345958485007, 5452.918206226989, 5456.208849716848, 5476.644018138808, 5321.521063104339, 5344.0, 5351.03681337363, 5353.866153346197, 5357.062514059946, 5352.678839269656, 5508.14623733322, 5509.641873278224, 5512.366077900932, 5516.972415137899, 5331.173668081454, 5349.0, 5351.5718742501285, 5354.6787192767, 5356.598255130959], "unit": "score", "name": "prototype.html", "value": 4055.389926763895}, {"lowerIsBetter": false, "replicates": [604.969751512424, 608.5831205624148, 618.4248995307305, 629.1914889367164, 652.0154566604429, 10911.618093366733, 10994.0, 11112.388818614983, 11118.722031949206, 11124.165687573433, 11409.20135590509, 11544.191906566522, 11552.422378881043, 11612.477438515267, 11614.0, 545.6753231827057, 642.2164958750317, 645.1548471502335, 656.0585559721791, 657.2769953051653, 661.2990230355814, 662.0268205737582, 665.4277321503528, 666.1373521289942, 678.2268214235775, 676.1784431915222, 681.0397339750953, 681.2982627893277, 681.7852376501411, 715.81388838902, 566.8752874367633, 671.5030877150922, 671.9563228390139, 675.0717763075771, 687.8761822871882, 502.04360692880124, 505.2244804225533, 506.53398873036895, 506.5694159964001, 523.748600671676, 10628.309159904582, 10685.519151638195, 10694.358338499715, 10694.732631684192, 10737.51681174349, 10472.528736206888, 10775.407352595605, 10783.83824242637, 10922.726931826688, 11155.776884462346, 8464.78838029048, 8583.613737381833, 9059.864102038475, 9350.251979841665, 9353.90646093544, 3095.7987730797427, 3123.9219019524467, 3164.0666003529013, 3164.335489547198, 3224.67753224678, 40550.18899621991, 40585.18829623391, 40962.38556421656, 41368.58631413707, 41772.79113604443, 8121.345394572348, 8257.463264887763, 8380.958095209486, 8457.238848503664, 8574.871376929352, 14030.859691403159, 14374.425022999172, 14398.568042958728, 14422.85577144236, 14504.419823207165, 5608.691521966331, 5728.656280623176, 5825.79609713658, 5861.208736820475, 5877.471027607536, 3520.718342532591, 3590.425531914881, 3614.855405783792, 3640.508531348287, 3642.21692336149, 2446.584080706284, 2467.3338198686615, 2488.8382255153356, 2489.9004039838564, 2501.0, 417.6491746932591, 461.7483471508036, 467.72638006765743, 471.1284124369888, 471.25776901379777, 358.87618771523785, 385.6586920575311, 474.71042663974947, 510.2117228881387, 514.6628958032495, 6290.1694237593265, 6433.1636887205295, 6524.184476940382, 6594.802155935234, 6676.9332306676315, 403.2519676000976, 425.1200015966919, 484.8157700073949, 485.74741134609803, 517.097664575311, 3197.635227913881, 3230.2893363460003, 3272.885449009273, 3279.3113446176094, 3370.224848284908, 46261.5373846264, 46450.53549464529, 47078.29382559264, 47484.28773568399, 47493.28760068602, 36597.451038234445, 37011.63331316998, 37426.62573374286, 37543.62456375456, 38043.0, 37683.246335073694, 38499.23001539954, 39019.99999999943, 39114.60885391109, 39203.41194882079, 7400.0, 7582.469227154046, 7610.6194690266375, 7671.693132274647, 7697.692092316244, 28825.0, 29064.564031539965, 29069.563956541093, 29591.0, 29752.70247297586, 36547.81726091352, 36999.26001480009, 37208.44187337246, 37770.244595108496, 38180.42729359117, 8972.0, 9036.683716069905, 9107.908920910706, 9161.129692679186, 9520.095590918852, 10486.895131048592, 10599.0, 10622.89377106219, 10661.733456663645, 10767.784644306914, 7824.552138201444, 9068.863967040368, 9444.150026497648, 9611.183049440875, 9653.420794752337, 7997.360211183208, 8591.828163436572, 8704.651813927372, 8881.023087460246, 8905.955470222607, 9218.0, 9283.907160928304, 9286.489243091695, 9394.107559781809, 9523.23814094857, 8192.221738934792, 8647.524386158822, 8652.341816021439, 8788.868166977629, 8853.203211710977, 8311.376646751396, 8329.541875196923, 8411.53736544496, 8625.353098517511, 8684.175003374668], "unit": "score", "name": "yui.html", "value": 5135.812997145}], "name": "dromaeo_css", "value": 5807.964661209238}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 108.0, 113.0, 114.0, 115.0, 103.0, 112.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [157.0, 133.0, 159.0, 174.0, 139.0, 169.0, 152.0, 136.0, 170.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 162.0, 161.0, 162.0, 163.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 120.0, 96.0, 73.0, 73.0, 75.0, 108.0, 106.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 146.0, 95.0, 95.0, 95.0, 142.0, 95.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 66.0, 68.0, 67.0, 68.0, 67.0, 78.0, 65.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.1}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 70.0, 70.0, 70.0, 71.0, 71.0, 71.0, 73.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 120.0, 127.0, 119.0, 138.0, 124.0, 120.0, 123.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 154.0, 151.0, 149.0, 135.0, 147.0, 148.0, 155.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 70.0, 71.0, 70.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1550.3000000000002}]} 05:12:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1550.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5807.96"}}} 05:12:36 INFO - Return code: 0 05:12:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:12:36 INFO - # TBPL SUCCESS # 05:12:36 INFO - Running post-action listener: _resource_record_post_action 05:12:36 INFO - Running post-run listener: _resource_record_post_run 05:12:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 525570048; Read time: 0; Write time: 1408320 05:12:37 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 233791488; Read time: 0; Write time: 898340 05:12:37 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 291639296; Read time: 0; Write time: 509888 05:12:37 INFO - Running post-run listener: _upload_blobber_files 05:12:37 INFO - Blob upload gear active. 05:12:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:12:37 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 05:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:12:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:39 INFO - (blobuploader) - INFO - Done attempting. 05:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:12:39 INFO - (blobuploader) - INFO - Done attempting. 05:12:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:12:39 INFO - Return code: 0 05:12:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:12:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:12:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a1cb95b8904680bc8daf774581f56ed082a37e1e1f4a0df6f76c1c267d663c0e4aee89ca5fe5f47e9e2971ecea05582cd483a2cb97bc1a85aa639e12f4636d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c6bd4e53978a466359f307c0bb029be47d59caad2d77cbf21575220e7232b5052f4238ddb791ce5465d34036d0675139ea09c4d8a70b9253bb27185a1befd6d"} 05:12:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:12:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:12:39 INFO - Contents: 05:12:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a1cb95b8904680bc8daf774581f56ed082a37e1e1f4a0df6f76c1c267d663c0e4aee89ca5fe5f47e9e2971ecea05582cd483a2cb97bc1a85aa639e12f4636d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c6bd4e53978a466359f307c0bb029be47d59caad2d77cbf21575220e7232b5052f4238ddb791ce5465d34036d0675139ea09c4d8a70b9253bb27185a1befd6d"} 05:12:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:12:39 INFO - Copying logs to upload dir... 05:12:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:12:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.674436 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-01 05:12:39.255275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 05:12:39.258633) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a1cb95b8904680bc8daf774581f56ed082a37e1e1f4a0df6f76c1c267d663c0e4aee89ca5fe5f47e9e2971ecea05582cd483a2cb97bc1a85aa639e12f4636d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c6bd4e53978a466359f307c0bb029be47d59caad2d77cbf21575220e7232b5052f4238ddb791ce5465d34036d0675139ea09c4d8a70b9253bb27185a1befd6d"} build_url:https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/P7yi610CQyujcMmrKMDQZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f6a1cb95b8904680bc8daf774581f56ed082a37e1e1f4a0df6f76c1c267d663c0e4aee89ca5fe5f47e9e2971ecea05582cd483a2cb97bc1a85aa639e12f4636d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c6bd4e53978a466359f307c0bb029be47d59caad2d77cbf21575220e7232b5052f4238ddb791ce5465d34036d0675139ea09c4d8a70b9253bb27185a1befd6d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 05:12:39.283209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:12:39.283528) ========= 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=df17445c3590ff7897617a0e00000225-1456836718.413249-1136643824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 05:12:39.369379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 05:12:39.369693) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 05:12:39.370003) ========= ========= Total master_lag: 0.28 =========